Hi Laurenz/Postgresql Team,
Perhaps, the issue I wanted to highlight here is that I get the same entry working when I switch user to
"pgddb_admin" and not when change user with same privileges as PGUSER "shc_uadmin" I get the message in the error log like "<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]" even though i see the next val from db. Please see below when logged in to the db and snippet of the code lines where it was throwing the error.
[shc_user@cucmtpccu1 ~]$ psql "host= cucmpsgsu0.postgres.database.azure.com port=5432 dbname=mshcd user=shc_uadmin password=abc123 sslmode=require options=--search_path=shc,public"
[shc_user@cucmtpccu1 ~]$ psql "host= cucmpsgsu0.postgres.database.azure.com port=5432 dbname=mshcd user=shc_uadmin password=abc123 sslmode=require options=--search_path=shc,public"
psql (16.1, server 15.4)
SSL connection (protocol: TLSv1.3, cipher: TLS_AES_256_GCM_SHA384, compression: off)
Type "help" for help.
SSL connection (protocol: TLSv1.3, cipher: TLS_AES_256_GCM_SHA384, compression: off)
Type "help" for help.
mshcd=> SELECT nextval('unassigned_pool_fa');
nextval
-------------
-1811939322
(1 row)
nextval
-------------
-1811939322
(1 row)
code snippet:
3555 } else {
3556 LOG_WARN("No File_address is found with status=free");
3557 //If no free address is found, get the next value available address from the sequence
3558 PQclear(res);
3559 res = PQexec(conn, "SELECT nextval('unassigned_pool_fa');");
3560 if (PQresultStatus(res) != PGRES_TUPLES_OK) {
3561 LOG_ERROR("SELECT nextval Failed");
3562 LOG_DEBUG("ROLLBACK TRANSACTION");
3563 res = PQexec(conn,"ROLLBACK TRANSACTION");
3564 PQclear(res);
3565 return 0;
3566 }
3556 LOG_WARN("No File_address is found with status=free");
3557 //If no free address is found, get the next value available address from the sequence
3558 PQclear(res);
3559 res = PQexec(conn, "SELECT nextval('unassigned_pool_fa');");
3560 if (PQresultStatus(res) != PGRES_TUPLES_OK) {
3561 LOG_ERROR("SELECT nextval Failed");
3562 LOG_DEBUG("ROLLBACK TRANSACTION");
3563 res = PQexec(conn,"ROLLBACK TRANSACTION");
3564 PQclear(res);
3565 return 0;
3566 }
Is the issue related to configuration of PGUSER or something else
Regards,
Sasmit Utkarsh
+91-7674022625
On Thu, Feb 22, 2024 at 4:20 PM Laurenz Albe <laurenz.albe@xxxxxxxxxxx> wrote:
On Thu, 2024-02-22 at 16:13 +0530, Sasmit Utkarsh wrote:
> On Thu, Feb 22, 2024 at 2:20 PM Laurenz Albe <laurenz.albe@xxxxxxxxxxx> wrote:
> > On Thu, 2024-02-22 at 14:01 +0530, Sasmit Utkarsh wrote:
> > > ==3343433==ERROR: AddressSanitizer: heap-buffer-overflow on address 0xf337ba80 at pc 0xf795fcdd bp 0xff8a74d8 sp 0xff8a70b0
> > > READ of size 4096 at 0xf337ba80 thread T0
> > > #0 0xf795fcdc in __interceptor_memcpy (/nix/store/3blqv6wzmwqgkkw45i6c8w0bkwldk418-gcc-12.2.0-lib/lib/libasan.so.8+0x42cdc)
> > > #1 0xf78c34bb in pqPutnchar (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x174bb)
> > > #2 0xf78be05e in PQsendQueryGuts (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x1205e)
> > > #3 0xf78c05a2 in PQexecPrepared (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x145a2)
> >
> > Perhaps you forgot to terminate a string with '\0'.
>
> Sorry but are you talking about the export variables in the result?
Whatever you fed to PQexecPrepared.
Yours,
Laurenz Albe
[shc_user@cucmtpccu1 ~]$ export PGHOST=cucmpsgsu0.postgres.database.azure.com
[shc_user@cucmtpccu1 ~]$ export PGDATABASE=mshcd
[shc_user@cucmtpccu1 ~]$ export PGUSER=shc_uadmin
[shc_user@cucmtpccu1 ~]$ export PGPASSWORD=3mnAK~lc7
[shc_user@cucmtpccu1 ~]$ export PGOPTIONS='--search_path=shc,shc_tty,public'
[shc_user@cucmtpccu1 ~]$ export PGUSER=pgddb_admin
[shc_user@cucmtpccu1 ~]$ export PGPASSWORD=xyz123
[shc_user@cucmtpccu1 ~]$ .nix-profile/bin/test 'K-T-*' -q
<6>3429958-[INFO] BUILD_TAG = jenkins-Tpfasmbuild1-515
<6>3429958-[INFO] sql_tty_connect_db: tty_conninfo:'dbname=shc_tty_data'
<6>3429958-[INFO] process_name=10.166.29.36#3429958
<7>3429958---------------------------------------------------------
<7>3429958- Using PostgreSQL database
<7>3429958---------------------------------------------------------
<7>3429958-SQL_init_db_connection() conninfo=dbname=shc_data
<7>3429958-SQL_init_db_connection() Connection to shc_data database SUCCESSFUL
<6>3429958-[INFO] PostgreSQL Server Version = 1500.4 protocol 3
<7>3429958-SQL_init_db_connection() PREPARE AdvisoryLockData PQresultStatus = PGRES_COMMAND_OK
<7>3429958-SQL_init_db_connection() PREPARE AdvisoryUnLockData PQresultStatus = PGRES_COMMAND_OK
<7>3429958-SQL_init_db_connection() PREPARE SelectSize PQresultStatus = PGRES_COMMAND_OK
<7>3429958-SQL_init_db_connection() PREPARE SelectData PQresultStatus = PGRES_COMMAND_OK
<7>3429958-SQL_init_db_connection() PREPARE InsertData PQresultStatus = PGRES_COMMAND_OK
<7>3429958-SQL_init_db_connection() PREPARE UpdateData PQresultStatus = PGRES_COMMAND_OK
<7>3429958-loading builtin FACE
<7>3429958-loading builtin FMSG
<7>3429958-loading builtin FMLG
<7>3429958-loading builtin UII1
<7>3429958-loading builtin UIO1
<7>3429958-loading builtin UIM1
<7>3429958-loading builtin UIY3
<7>3429958-loading builtin UIY2
<7>3429958-loading builtin UIY1
<7>3429958-loading builtin UIZ1
<7>3429958-loading builtin WGA1
<7>3429958-loading builtin COPA
<7>3429958-loading builtin HCVT
<7>3429958-loading builtin HTEA
<7>3429958-loading builtin WGR1
<7>3429958-loading builtin UGK6
<7>3429958-loading builtin UGK7
<7>3429958-loading builtin CVFG
<7>3429958-loading builtin GMI9
<7>3429958-loading builtin HLOG
<7>3429958-loading builtin GMI8
<7>3429958-loading builtin UMA1
<7>3429958-loading builtin UMD1
<7>3429958-loading builtin UMS1
<7>3429958-loading builtin UGI1
<7>3429958-loading builtin HTCZ
<7>3429958-loading builtin C000
<7>3429958-loading builtin HRD4
<7>3429958-loading builtin HTCY
<4>3429958-[WARN] init_globals() not fully unimplemented
<7>3429958-init_globals() load_core_resident
<4>3429958-[WARN] Init dbref_SW05SR
<4>3429958-[WARN] Init dbref_SR05SR
<4>3429958-[WARN] Init dbref_GW01SR
<4>3429958-[WARN] Init dbref_SEQ0SW
<4>3429958-[WARN] Init dbref_FFQ0SW
<4>3429958-[WARN] Init dbref_PNR0SW
<7>3429958-init_pool()
<7>3429958-/fs-data/POOL.DAT file already exists
<7>3429958-getFreeFileAddr()
<7>3429958-getActiveTape()
<7>3429958-1 tuples returned
<7>3429958-getActiveTape()
<7>3429958-1 tuples returned
<7>3429958-getActiveTape()
<7>3429958-1 tuples returned
<7>3429958-initializing segment DRIV transfer vector
<7>3429958-initializing tvp[0]=DRV1 nmix=642637 tsv=1
<7>3429958-initializing tvp[1]=DRV2 nmix=642638 tsv=2
<7>3429958-initializing tvp[2]=DRV3 nmix=642639 tsv=3
<7>3429958-initializing tvp[3]=DRV4 nmix=642640 tsv=4
<7>3429958-initializing tvp[4]=DRV5 nmix=642641 tsv=5
<7>3429958-initializing tvp[5]=DRV6 nmix=642642 tsv=6
<7>3429958-initializing tvp[6]=DRV7 nmix=642643 tsv=7
<7>3429958-initializing tvp[7]=DRV8 nmix=642644 tsv=8
<7>3429958-initializing tvp[8]=DRV9 nmix=642645 tsv=9
<7>3429958-initializing tvp[9]=DRVA nmix=642646 tsv=10
<7>3429958-initializing tvp[10]=DRVB nmix=642647 tsv=11
<7>3429958-initializing tvp[11]=DRVC nmix=642648 tsv=12
<7>3429958-initializing tvp[12]=DRVD nmix=642649 tsv=13
<7>3429958-initializing tvp[13]=DRVE nmix=642650 tsv=14
<7>3429958-initializing segment EWE0 transfer vector
<7>3429958-initializing tvp[0]=EWEX nmix=695193 tsv=1
<7>3429958-initializing tvp[1]=EWEY nmix=695194 tsv=2
<7>3429958-initializing tvp[2]=EWEZ nmix=695195 tsv=3
<7>3429958-initializing segment EWF1 transfer vector
<7>3429958-initializing tvp[0]=EWFB nmix=695207 tsv=1
<7>3429958-initializing segment EWP3 transfer vector
<7>3429958-initializing tvp[0]=EWPA nmix=695566 tsv=1
<7>3429958-initializing segment IRB1 transfer vector
<7>3429958-initializing tvp[0]=IRB2 nmix=875198 tsv=1
<7>3429958-initializing tvp[1]=IRB3 nmix=875199 tsv=2
<7>3429958-initializing tvp[2]=IRB4 nmix=875200 tsv=3
<7>3429958-initializing tvp[3]=IRB5 nmix=875201 tsv=4
<7>3429958-initializing tvp[4]=IRB6 nmix=875202 tsv=5
<7>3429958-initializing tvp[5]=IRB7 nmix=875203 tsv=6
<7>3429958-initializing tvp[6]=IRB8 nmix=875204 tsv=7
<7>3429958-initializing tvp[7]=IRB9 nmix=875205 tsv=8
<7>3429958-initializing tvp[8]=IRBA nmix=875206 tsv=9
<7>3429958-initializing tvp[9]=IRBB nmix=875207 tsv=10
<7>3429958-initializing tvp[10]=IRBC nmix=875208 tsv=11
<7>3429958-initializing tvp[11]=IRBD nmix=875209 tsv=12
<7>3429958-initializing tvp[12]=IRBE nmix=875210 tsv=13
<7>3429958-initializing tvp[13]=IRBF nmix=875211 tsv=14
<7>3429958-initializing segment IRF1 transfer vector
<7>3429958-initializing tvp[0]=IRFA nmix=875350 tsv=1
<7>3429958-initializing segment IRO1 transfer vector
<7>3429958-initializing tvp[0]=IRO2 nmix=875666 tsv=1
<7>3429958-initializing tvp[1]=IRO3 nmix=875667 tsv=2
<7>3429958-initializing segment IRS1 transfer vector
<7>3429958-initializing tvp[0]=IRS2 nmix=875810 tsv=1
<7>3429958-initializing tvp[1]=IRS3 nmix=875811 tsv=2
<7>3429958-initializing segment KCD8 transfer vector
<7>3429958-initializing tvp[0]=KCDC nmix=949152 tsv=1
<7>3429958-initializing segment KKV1 transfer vector
<7>3429958-initializing tvp[0]=KKVA nmix=960166 tsv=1
<7>3429958-initializing segment NFA7 transfer vector
<7>3429958-initializing tvp[0]=NFAZ nmix=1092923 tsv=1
<7>3429958-initializing segment NFD4 transfer vector
<7>3429958-initializing tvp[0]=NFDA nmix=1093006 tsv=1
<7>3429958-initializing segment PQD4 transfer vector
<7>3429958-initializing tvp[0]=PQD5 nmix=1200569 tsv=1
<7>3429958-initializing tvp[1]=PQD6 nmix=1200570 tsv=2
<7>3429958-initializing segment PQV5 transfer vector
<7>3429958-initializing tvp[0]=PQV6 nmix=1201218 tsv=1
<7>3429958-initializing tvp[1]=PQV7 nmix=1201219 tsv=2
<7>3429958-initializing segment PRE6 transfer vector
<7>3429958-initializing tvp[0]=PREZ nmix=1201931 tsv=1
<7>3429958-initializing segment SAB0 transfer vector
<7>3429958-initializing tvp[0]=S1B0 nmix=1308060 tsv=1
<7>3429958-initializing segment SAB4 transfer vector
<7>3429958-initializing tvp[0]=S1B4 nmix=1308064 tsv=1
<7>3429958-initializing segment SAED transfer vector
<7>3429958-initializing tvp[0]=S1ED nmix=1308181 tsv=1
<7>3429958-initializing tvp[1]=S2ED nmix=1309477 tsv=2
<7>3429958-initializing tvp[2]=S3ED nmix=1310773 tsv=3
<7>3429958-initializing segment SAF2 transfer vector
<7>3429958-initializing tvp[0]=S1F2 nmix=1308206 tsv=1
<7>3429958-initializing segment SAI1 transfer vector
<7>3429958-initializing tvp[0]=S1I1 nmix=1308313 tsv=1
<7>3429958-initializing tvp[1]=S2I1 nmix=1309609 tsv=2
<7>3429958-initializing segment SAI4 transfer vector
<7>3429958-initializing tvp[0]=S1I4 nmix=1308316 tsv=1
<7>3429958-initializing tvp[1]=S2I4 nmix=1309612 tsv=2
<7>3429958-initializing tvp[2]=S3I4 nmix=1310908 tsv=3
<7>3429958-initializing segment SAI7 transfer vector
<7>3429958-initializing tvp[0]=S1I7 nmix=1308319 tsv=1
<7>3429958-initializing tvp[1]=S2I7 nmix=1309615 tsv=2
<7>3429958-initializing segment SAM2 transfer vector
<7>3429958-initializing tvp[0]=S1M2 nmix=1308458 tsv=1
<7>3429958-initializing segment SASX transfer vector
<7>3429958-initializing tvp[0]=S1SX nmix=1308705 tsv=1
<7>3429958-initializing segment TIK3 transfer vector
<7>3429958-initializing tvp[0]=TIKA nmix=1377082 tsv=1
<7>3429958-initializing segment TOQ1 transfer vector
<7>3429958-initializing tvp[0]=TOQA nmix=1385074 tsv=1
<7>3429958-initializing segment TOS1 transfer vector
<7>3429958-initializing tvp[0]=TOSA nmix=1385146 tsv=1
<7>3429958-initializing tvp[1]=TOSB nmix=1385147 tsv=2
<7>3429958-initializing tvp[2]=TOSC nmix=1385148 tsv=3
<7>3429958-initializing tvp[3]=TOSD nmix=1385149 tsv=4
<7>3429958-initializing segment UCC3 transfer vector
<7>3429958-initializing tvp[0]=UCCA nmix=1415674 tsv=1
<7>3429958-initializing segment UCL1 transfer vector
<7>3429958-initializing tvp[0]=U1L1 nmix=1401733 tsv=1
<7>3429958-initializing tvp[1]=U2L1 nmix=1403029 tsv=2
<7>3429958-initializing segment UL11 transfer vector
<7>3429958-initializing tvp[0]=UL12 nmix=1426934 tsv=1
<7>3429958-initializing segment WIM1 transfer vector
<7>3429958-initializing tvp[0]=WIMZ nmix=1517147 tsv=1
<7>3429958-initializing segment WIM2 transfer vector
<7>3429958-initializing tvp[0]=WIMA nmix=1517122 tsv=1
<7>3429958-initializing segment EWF2 transfer vector
<7>3429958-initializing tvp[0]=EWFA nmix=695206 tsv=1
<7>3429958-initializing segment ICC1 transfer vector
<7>3429958-initializing tvp[0]=ICCA nmix=855802 tsv=1
<7>3429958-initializing segment KDH0 transfer vector
<7>3429958-initializing tvp[0]=KDHA nmix=950590 tsv=1
<7>3429958-initializing segment KUU0 transfer vector
<7>3429958-initializing tvp[0]=KUUM nmix=973102 tsv=1
<7>3429958-initializing tvp[1]=KUUN nmix=973103 tsv=2
<7>3429958-initializing segment PTJ5 transfer vector
<7>3429958-initializing tvp[0]=PTJB nmix=1204679 tsv=1
<7>3429958-initializing tvp[1]=PTJC nmix=1204680 tsv=2
<7>3429958-initializing segment RIQ3 transfer vector
<7>3429958-initializing tvp[0]=RIQ9 nmix=1283985 tsv=1
<7>3429958-initializing segment SAA0 transfer vector
<7>3429958-initializing tvp[0]=S1A0 nmix=1308024 tsv=1
<7>3429958-initializing tvp[1]=S2A0 nmix=1309320 tsv=2
<7>3429958-initializing segment SAA4 transfer vector
<7>3429958-initializing tvp[0]=S1A4 nmix=1308028 tsv=1
<7>3429958-initializing segment SAAA transfer vector
<7>3429958-initializing tvp[0]=S1AA nmix=1308034 tsv=1
<7>3429958-initializing tvp[1]=S2AA nmix=1309330 tsv=2
<7>3429958-initializing tvp[2]=S3AA nmix=1310626 tsv=3
<7>3429958-initializing segment SAC5 transfer vector
<7>3429958-initializing tvp[0]=S1C5 nmix=1308101 tsv=1
<7>3429958-initializing tvp[1]=S2C5 nmix=1309397 tsv=2
<7>3429958-initializing tvp[2]=S3C5 nmix=1310693 tsv=3
<7>3429958-initializing segment SAC6 transfer vector
<7>3429958-initializing tvp[0]=S1C6 nmix=1308102 tsv=1
<7>3429958-initializing segment SACA transfer vector
<7>3429958-initializing tvp[0]=S1CA nmix=1308106 tsv=1
<7>3429958-initializing segment SAF1 transfer vector
<7>3429958-initializing tvp[0]=S1F1 nmix=1308205 tsv=1
<7>3429958-initializing tvp[1]=S2F1 nmix=1309501 tsv=2
<7>3429958-initializing tvp[2]=S3F1 nmix=1310797 tsv=3
<7>3429958-initializing tvp[3]=S4F1 nmix=1312093 tsv=4
<7>3429958-initializing segment SAF3 transfer vector
<7>3429958-initializing tvp[0]=S1F3 nmix=1308207 tsv=1
<7>3429958-initializing segment SAF4 transfer vector
<7>3429958-initializing tvp[0]=S1F4 nmix=1308208 tsv=1
<7>3429958-initializing segment SAF6 transfer vector
<7>3429958-initializing tvp[0]=S1F6 nmix=1308210 tsv=1
<7>3429958-initializing segment SAF8 transfer vector
<7>3429958-initializing tvp[0]=S1F8 nmix=1308212 tsv=1
<7>3429958-initializing segment SAF9 transfer vector
<7>3429958-initializing tvp[0]=S1F9 nmix=1308213 tsv=1
<7>3429958-initializing segment SAI8 transfer vector
<7>3429958-initializing tvp[0]=S1I8 nmix=1308320 tsv=1
<7>3429958-initializing tvp[1]=S2I8 nmix=1309616 tsv=2
<7>3429958-initializing tvp[2]=S3I8 nmix=1310912 tsv=3
<7>3429958-initializing segment SAIB transfer vector
<7>3429958-initializing tvp[0]=S1IB nmix=1308323 tsv=1
<7>3429958-initializing tvp[1]=S2IB nmix=1309619 tsv=2
<7>3429958-initializing segment SAIC transfer vector
<7>3429958-initializing tvp[0]=S1IC nmix=1308324 tsv=1
<7>3429958-initializing segment SAM3 transfer vector
<7>3429958-initializing tvp[0]=S1M3 nmix=1308459 tsv=1
<7>3429958-initializing segment SAR5 transfer vector
<7>3429958-initializing tvp[0]=S1R5 nmix=1308641 tsv=1
<7>3429958-initializing tvp[1]=S2R5 nmix=1309937 tsv=2
<7>3429958-initializing segment SAS2 transfer vector
<7>3429958-initializing tvp[0]=S1S2 nmix=1308674 tsv=1
<7>3429958-initializing segment SAS6 transfer vector
<7>3429958-initializing tvp[0]=S1S6 nmix=1308678 tsv=1
<7>3429958-initializing segment SAS9 transfer vector
<7>3429958-initializing tvp[0]=S1S9 nmix=1308681 tsv=1
<7>3429958-initializing segment SASD transfer vector
<7>3429958-initializing tvp[0]=S1SD nmix=1308685 tsv=1
<7>3429958-initializing segment SASE transfer vector
<7>3429958-initializing tvp[0]=S1SE nmix=1308686 tsv=1
<7>3429958-initializing tvp[1]=S2SE nmix=1309982 tsv=2
<7>3429958-initializing tvp[2]=S3SE nmix=1311278 tsv=3
<7>3429958-initializing tvp[3]=S4SE nmix=1312574 tsv=4
<7>3429958-initializing segment SASG transfer vector
<7>3429958-initializing tvp[0]=S1SG nmix=1308688 tsv=1
<7>3429958-initializing tvp[1]=S2SG nmix=1309984 tsv=2
<7>3429958-initializing tvp[2]=S3SG nmix=1311280 tsv=3
<7>3429958-initializing segment SASW transfer vector
<7>3429958-initializing tvp[0]=S1SW nmix=1308704 tsv=1
<7>3429958-initializing segment SAZU transfer vector
<7>3429958-initializing tvp[0]=S1ZU nmix=1308954 tsv=1
<7>3429958-initializing segment SPR0 transfer vector
<7>3429958-initializing tvp[0]=SPR1 nmix=1339741 tsv=1
<7>3429958-initializing segment TOC3 transfer vector
<7>3429958-initializing tvp[0]=TOCA nmix=1384570 tsv=1
<7>3429958-initializing segment TOE8 transfer vector
<7>3429958-initializing tvp[0]=TOEA nmix=1384642 tsv=1
<7>3429958-initializing segment TOS2 transfer vector
<7>3429958-initializing tvp[0]=TOSE nmix=1385150 tsv=1
<7>3429958-initializing segment WIN1 transfer vector
<7>3429958-initializing tvp[0]=WINA nmix=1517158 tsv=1
<7>3429958-initializing segment WINB transfer vector
<7>3429958-initializing tvp[0]=WINH nmix=1517165 tsv=1
<7>3429958-initializing segment SAC9 transfer vector
<7>3429958-initializing tvp[0]=S1C9 nmix=1308105 tsv=1
<7>3429958-initializing tvp[1]=S2C9 nmix=1309401 tsv=2
<7>3429958-initializing tvp[2]=S3C9 nmix=1310697 tsv=3
<7>3429958-msginit() LNIATA = F66000
<6>3429958-[INFO] process_termdefn() unimplemented
<7>3429958-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(16146432)
<7>3429958-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3429958-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3429958-init_aaa WA0VED=00
<7>3429958-Entry type 00/Non-RPC entry
<7>3429958-call_appl_entry WA0ROL=0000
<7>3429958-call_appl_entry WA0VED=00
<7>3429958-CAPIC(action=S,capeq=0)
<7>3429958-call_appl_entry entering UGT1
<7>3429958-1: entering segment UGT1
<7>3429958-1: entering segment PCHA
<6>3429958-[INFO] LEVTA(0) returning 1
<6>3429958-[INFO] LEVTA(1) returning 1
<7>3429958-1: entering segment PCHC
<6>3429958-[INFO] LEVTA(0) returning 1
<7>3429958-1: entering segment PCHK
<7>3429958-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(-335504555)
<7>3429958-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3429958-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3429958-2: entering segment PCHD
<7>3429958-3: entering segment UCP1
<7>3429958-BACKC to 2: PCHD
<4>3429958-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3429958-get_pool_fa()
<4>3429958-[WARN] No File_address is found with status=free
<6>3429958-[INFO] Select nextval success ntuples(1)
<6>3429958-[INFO] File Address (-1811903030)
<7>3429958-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(-1811903030)
<7>3429958-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3429958-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<3>3429958-[ERROR] SELECT failed: NO ROWS RETURNED [../tpfasm.c:4826:SQL_get_tpf_rw]
<3>3429958-[ERROR] INVALID_FILE_ADDRESS 94008DCA [../tpfasm.c:4829:SQL_get_tpf_rw]
<4>3429958-[WARN] fa=94008dca does not exist. initializing
<7>3429958-SQL_create_fa() InsertDataCommand = CALL SQL_insert_data_procedure($1, $2, $3, $4, $5, $6, $7, NULL) $1=-1811903030 $2=0 $3=999 $4=94008DCA $5=FD0F $6=4096
<7>3429958-SQL_create_fa() InsertDataNParams = 7
<7>3429958-SQL_create_fa() res = PGRES_TUPLES_OK
<7>3429958-SQL_lock_row() - AdvisoryLockDataCommand = SELECT pg_advisory_lock($1) $1=-1811903030
---------------------------------------------------------------------------------------------
locktype classid objid mode pid virtualtransaction
advisory 4294967295 2483064266 ExclusiveLock 8154 54/232740
advisory 4294967295 4121489337 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 12155 31/171239
advisory 4294967295 2483049822 ExclusiveLock 11980 44/0
advisory 4294967295 4113008483 ExclusiveLock 11980 44/0
advisory 4294967295 2483049865 ExclusiveLock 11980 44/0
advisory 4294967295 3894542871 ExclusiveLock 11980 44/0
advisory 4294967295 4113471907 ExclusiveLock 11980 44/0
advisory 4294967295 4123481114 ExclusiveLock 11980 44/0
advisory 4294967295 4117704183 ExclusiveLock 11980 44/0
advisory 4294967295 4134623665 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 11980 44/0
---------------------------------------------------------------------------------------------
<7>3429958-SQL_lock_row() QresultStatus = PGRES_TUPLES_OK
<7>3429958-SQL_create_fa(), INSERT SUCCESSFUL
<7>3429958-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(-1811903030)
<7>3429958-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3429958-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3429958-SQL_unlock_row() - AdvisoryUnLockDataCommand = SELECT pg_advisory_unlock($1) $1=-1811903030
---------------------------------------------------------------------------------------------
locktype classid objid mode pid virtualtransaction
advisory 4294967295 4121489337 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 12155 31/171239
advisory 4294967295 2483049822 ExclusiveLock 11980 44/0
advisory 4294967295 4113008483 ExclusiveLock 11980 44/0
advisory 4294967295 2483049865 ExclusiveLock 11980 44/0
advisory 4294967295 3894542871 ExclusiveLock 11980 44/0
advisory 4294967295 4113471907 ExclusiveLock 11980 44/0
advisory 4294967295 4123481114 ExclusiveLock 11980 44/0
advisory 4294967295 4117704183 ExclusiveLock 11980 44/0
advisory 4294967295 4134623665 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 11980 44/0
---------------------------------------------------------------------------------------------
<7>3429958-SQL_unlock_row() PQresultStatus = PGRES_TUPLES_OK
<7>3429958-SQL_put_tpf_rw() UpdateDataCommand = CALL SQL_update_data_procedure($1, $2, $3) unhold(0) fa(-1811903030)
<7>3429958-SQL_put_tpf_rw() UpdateDataNParams = 3
<7>3429958-SQL_put_tpf_rw() res = PGRES_COMMAND_OK
<7>3429958-SQL_put_tpf_rw() rc = 0
<7>3429958-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(-1811903030)
<7>3429958-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3429958-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3429958-BACKC to 1: PCHK
<7>3429958-2: entering segment PCHD
<7>3429958-BACKC to 1: PCHK
<7>3429958-2: entering segment PCHD
<7>3429958-BACKC to 1: PCHK
<7>3429958-2: entering segment PCHD
<7>3429958-BACKC to 1: PCHK
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<4>3429958-[WARN] No PKY in keys for DBRED
<7>3429958-SQL_put_tpf_rw() UpdateDataCommand = CALL SQL_update_data_procedure($1, $2, $3) unhold(0) fa(-1811903030)
<7>3429958-SQL_put_tpf_rw() UpdateDataNParams = 3
<7>3429958-SQL_put_tpf_rw() res = PGRES_COMMAND_OK
<7>3429958-SQL_put_tpf_rw() rc = 0
<7>3429958-SQL_put_tpf_rw() UpdateDataCommand = CALL SQL_update_data_procedure($1, $2, $3) unhold(1) fa(-1811903030)
<7>3429958-SQL_put_tpf_rw() UpdateDataNParams = 3
WARNING: you don't own a lock of type ExclusiveLock
<7>3429958-SQL_put_tpf_rw() res = PGRES_COMMAND_OK
---------------------------------------------------------------------------------------------
locktype classid objid mode pid virtualtransaction
advisory 4294967295 4121489337 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 12155 31/171239
advisory 4294967295 2483049822 ExclusiveLock 11980 44/0
advisory 4294967295 4113008483 ExclusiveLock 11980 44/0
advisory 4294967295 2483049865 ExclusiveLock 11980 44/0
advisory 4294967295 3894542871 ExclusiveLock 11980 44/0
advisory 4294967295 4113471907 ExclusiveLock 11980 44/0
advisory 4294967295 4123481114 ExclusiveLock 11980 44/0
advisory 4294967295 4117704183 ExclusiveLock 11980 44/0
advisory 4294967295 4134623665 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 11980 44/0
---------------------------------------------------------------------------------------------
<7>3429958-SQL_put_tpf_rw() rc = 0
<7>3429958-SQL_unlock_row() - AdvisoryUnLockDataCommand = SELECT pg_advisory_unlock($1) $1=-1811903030
WARNING: you don't own a lock of type ExclusiveLock
---------------------------------------------------------------------------------------------
locktype classid objid mode pid virtualtransaction
advisory 4294967295 4121489337 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 12155 31/171239
advisory 4294967295 2483049822 ExclusiveLock 11980 44/0
advisory 4294967295 4113008483 ExclusiveLock 11980 44/0
advisory 4294967295 2483049865 ExclusiveLock 11980 44/0
advisory 4294967295 3894542871 ExclusiveLock 11980 44/0
advisory 4294967295 4113471907 ExclusiveLock 11980 44/0
advisory 4294967295 4123481114 ExclusiveLock 11980 44/0
advisory 4294967295 4117704183 ExclusiveLock 11980 44/0
advisory 4294967295 4134623665 ExclusiveLock 11980 44/0
advisory 4294967295 3830554497 ExclusiveLock 11980 44/0
---------------------------------------------------------------------------------------------
<7>3429958-SQL_unlock_row() PQresultStatus = PGRES_TUPLES_OK
<3>3429958-[ERROR] termbuff is not empty at exit termbuffn=960 [../tpfasm.c:5423:EXITC]
<7>3429958-ROUTC(LEVEL=-2 LIST=-5424000={DES=F6600000 ORG=00000000 CTL0=00 CTL1=00 CTL2=10 CTL3=00 CTL4=00 CTL5=00}) in PCHK
<7>3429958-ROUTC: msgl:'960'
<6>3429958-[INFO] 000 40404040 D7D9C5D4 C9E4D440 C3E4E2E3 PREM IUM CUST
<6>3429958-[INFO] 010 D6D4C5D9 40C8C1D5 C4D3C9D5 C740D7C3 OMER HAN DLING PC
<6>3429958-[INFO] 020 C840E3C1 C2D3C540 C6D6D940 C3D44040 H TABLE FOR CM
<6>3429958-[INFO] 030 4040F0F7 F5F94040 F0F6C6C5 C2F2F415 0759 06FEB24.
<6>3429958-[INFO] 040 40404040 40404040 40404040 40D3C1E2 LAS
<6>3429958-[INFO] 050 E340E4D7 C4C1E3C5 C440F1F2 F3F940F0 T UPDATE D 1239 0
<6>3429958-[INFO] 060 F7D4C1D9 F1F840C2 E840C3D9 C360E2E4 7MAR18 B Y CRC-SU
<6>3429958-[INFO] 070 60D4C240 4040D6D5 40F6F0F6 F9F1F115 -MB ON 606911.
<6>3429958-[INFO] 080 E2E3C1D9 60E2E3C1 D940C1D3 D3C9C1D5 STAR-STA R ALLIAN
<6>3429958-[INFO] 090 C3C54B4B 4B40F2F9 60D7C1D9 E3D5C5D9 CE... 29 -PARTNER
<6>3429958-[INFO] 0A0 E240C8C1 E3C9C5D9 60D540C8 C9E3C9C5 S HATIER -N HITIE
<6>3429958-[INFO] 0B0 D960F040 D9C5C360 D7D9C9D4 C1D9E815 R-0 REC- PRIMARY.
<6>3429958-[INFO] 0C0 4040D7C1 D9E3D5C5 D9E260C3 D440E4C1 PARTNE RS-CM UA
<6>3429958-[INFO] 0D0 40D6E940 E3D240E2 D240E3C1 40C1E540 OZ TK S K TA AV
<6>3429958-[INFO] 0E0 D1D740C1 F340C1C3 40C3C140 D5E940D5 JP A3 AC CA NZ N
<6>3429958-[INFO] 0F0 C840D6E2 40E2D540 D6E440D4 E2154040 H OS SN OU MS.
<6>3429958-[INFO] 100 40404040 40404040 40C5E340 D3D640D3 ET LO L
<6>3429958-[INFO] 110 C840E2D8 40E2C140 D3E740E3 D740E3C7 H SQ SA LX TP TG
<6>3429958-[INFO] 120 40E9C840 C2D940C1 C940D6F6 154040C3 ZH BR A I O6. C
<6>3429958-[INFO] 130 D44040C4 C1E3C140 C5E7C3C8 C1D5C7C5 M DATA EXCHANGE
<6>3429958-[INFO] 140 40D6D7E3 C9D6D5E2 406040C1 D3D3C9C1 OPTIONS - ALLIA
<6>3429958-[INFO] 150 D5C3C540 E2E3C1D5 C4C1D9C4 40C4C5C6 NCE STAN DARD DEF
<6>3429958-[INFO] 160 C1E4D3E3 E240D6C6 40C3D415 4040C3C1 AULTS OF CM. CA
<6>3429958-[INFO] 170 D9D9C9C5 D94060C3 D44040E3 E3E860E2 RRIER -C M TTY-S
<6>3429958-[INFO] 180 C5D5C460 D9C5C3E5 60E3C9C5 D960E3E8 END-RECV -TIER-TY
<6>3429958-[INFO] 190 D7C54060 D5154040 4040D4E2 C740E3D6 PE -N. MSG TO
<6>3429958-[INFO] 1A0 40D6C140 C5E7D760 C6C660E3 D660F1C1 OA EXP- FF-TO-1A
<6>3429958-[INFO] 1B0 40E84040 C9D4D760 C6C660C6 D960F1C1 Y IMP- FF-FR-1A
<6>3429958-[INFO] 1C0 4040E840 C9C1E3C1 D7D5D360 E660E3C9 Y IATA PNL-W-TI
<6>3429958-[INFO] 1D0 C5D940E8 15404040 40404040 40404040 ER Y.
<6>3429958-[INFO] 1E0 4040E3E3 E860E2C5 D5C460E3 C9C5D940 TTY-SE ND-TIER
<6>3429958-[INFO] 1F0 E84040C1 C9D9C9D4 D760E2E2 D9D6D7E3 Y AIRIM P-SSROPT
<6>3429958-[INFO] 200 40F140C6 D8E3E560 E2C5D760 C3C8C1D9 1 FQTV- SEP-CHAR
<6>3429958-[INFO] 210 40404B15 40404040 D4E2C740 C6D940D6 .. MSG FR O
<6>3429958-[INFO] 220 C140C5E7 D760C6C6 60E3D660 F1C140E8 A EXP-FF -TO-1A Y
<6>3429958-[INFO] 230 4040C9D4 D760C6C6 60C6D960 F1C14040 IMP-FF -FR-1A
<6>3429958-[INFO] 240 E840C9C1 E3C1D7D5 D360E660 E3C9C5D9 Y IATAPN L-W-TIER
<6>3429958-[INFO] 250 40E81540 40404040 40404040 40404040 Y.
<6>3429958-[INFO] 260 E3E3E860 D9C5C3E5 60E3C9C5 D940E840 TTY-RECV -TIER Y
<6>3429958-[INFO] 270 40C1C9D9 C9D4D760 E2E2D9D6 D7E340F1 AIRIMP- SSROPT 1
<6>3429958-[INFO] 280 40C6D8E3 E560E2C5 D760C3C8 C1D94040 FQTV-SE P-CHAR
<6>3429958-[INFO] 290 4B154040 E3C9C5D9 40F1404B 4B4B4B4B .. TIER 1 .....
<6>3429958-[INFO] 2A0 4B4B4B40 C1D3D7C8 C1E3C9C5 D94060C7 ... ALPH ATIER -G
<6>3429958-[INFO] 2B0 15404040 40C1C3C9 60E3C5E7 E3605CC7 . ACI -TEXT-*G
<6>3429958-[INFO] 2C0 4B4B40C2 D7C1E2E2 60E3C5E7 E360E2E3 .. BPASS -TEXT-ST
<6>3429958-[INFO] 2D0 C1D940C7 D6D3C44B 4B4B4B4B 4B4B4B4B AR GOLD. ........
<6>3429958-[INFO] 2E0 4B40D7D9 C960E6D3 C9E2E360 D7C14B15 . PRI-WL IST-PA..
<6>3429958-[INFO] 2F0 40404040 C3D9E660 E3C5E7E3 605CC74B CRW- TEXT-*G.
<6>3429958-[INFO] 300 4B40E3C3 C9D4C760 E3C5E7E3 605CC74B . TCIMG- TEXT-*G.
<6>3429958-[INFO] 310 4B4B4B4B 4B4B4B4B 4B4B4B4B 4B4B4B4B ........ ........
<6>3429958-[INFO] 320 154040E3 C9C5D940 F2404B4B 4B4B4B4B . TIER 2 ......
<6>3429958-[INFO] 330 4B4B40C1 D3D7C8C1 E3C9C5D9 4060E215 .. ALPHA TIER -S.
<6>3429958-[INFO] 340 40404040 C1C3C960 E3C5E7E3 605CE24B ACI- TEXT-*S.
<6>3429958-[INFO] 350 4B40C2D7 C1E2E260 E3C5E7E3 60E2E3C1 . BPASS- TEXT-STA
<6>3429958-[INFO] 360 D940E2C9 D3E5C5D9 4B4B4B4B 4B4B4B4B R SILVER ........
<6>3429958-[INFO] 370 40D7D9C9 60E6D3C9 E2E360D7 C24B1540 PRI-WLI ST-PB..
<6>3429958-[INFO] 380 404040C3 D9E660E3 C5E7E360 5CE24B4B CRW-T EXT-*S..
<6>3429958-[INFO] 390 40E3C3C9 D4C760E3 C5E7E360 5CE24B4B TCIMG-T EXT-*S..
<6>3429958-[INFO] 3A0 4B4B4B4B 4B4B4B4B 4B4B4B4B 4B4B4B15 ........ ........
<6>3429958-[INFO] 3B0 15C5D5C4 40D6C640 C4C9E2D7 D3C1E815 .END OF DISPLAY.
<7>3429958-ROUTC: lniata:'F66000'
<7>3429958-ROUTC 960 bytes to F66000
<6>3429958-[INFO] PREMIUM CUSTOMER HANDLING PCH TABLE FOR CM 0759 06FEB24
<6>3429958-[INFO] LAST UPDATED 1239 07MAR18 BY CRC-SU-MB ON 606911
<6>3429958-[INFO] STAR-STAR ALLIANCE... 29-PARTNERS HATIER-N HITIER-0 REC-PRIMARY
<6>3429958-[INFO] PARTNERS-CM UA OZ TK SK TA AV JP A3 AC CA NZ NH OS SN OU MS
<6>3429958-[INFO] ET LO LH SQ SA LX TP TG ZH BR AI O6
<6>3429958-[INFO] CM DATA EXCHANGE OPTIONS - ALLIANCE STANDARD DEFAULTS OF CM
<6>3429958-[INFO] CARRIER -CM TTY-SEND-RECV-TIER-TYPE -N
<6>3429958-[INFO] MSG TO OA EXP-FF-TO-1A Y IMP-FF-FR-1A Y IATAPNL-W-TIER Y
<6>3429958-[INFO] TTY-SEND-TIER Y AIRIMP-SSROPT 1 FQTV-SEP-CHAR .
<6>3429958-[INFO] MSG FR OA EXP-FF-TO-1A Y IMP-FF-FR-1A Y IATAPNL-W-TIER Y
<6>3429958-[INFO] TTY-RECV-TIER Y AIRIMP-SSROPT 1 FQTV-SEP-CHAR .
<6>3429958-[INFO] TIER 1 ........ ALPHATIER -G
<6>3429958-[INFO] ACI-TEXT-*G.. BPASS-TEXT-STAR GOLD.......... PRI-WLIST-PA.
<6>3429958-[INFO] CRW-TEXT-*G.. TCIMG-TEXT-*G.................
<6>3429958-[INFO] TIER 2 ........ ALPHATIER -S
<6>3429958-[INFO] ACI-TEXT-*S.. BPASS-TEXT-STAR SILVER........ PRI-WLIST-PB.
<6>3429958-[INFO] CRW-TEXT-*S.. TCIMG-TEXT-*S.................
<6>3429958-[INFO]
<6>3429958-[INFO] END OF DISPLAY
<3>3429958-[ERROR] EXITC() Level 1 still has mmapd file 0xf3317ce4 size 1056. call release_tpf() [../tpfasm.c:5469:EXITC]
<7>3429958-Exiting.
<3>3429958-[ERROR] Exiting due to file open [../tpfdf_tpf.c:141:cleanup_tpfdf]
<6>3429958-[INFO] message: 46690 µs / msginit: 2770 µs / sysinit: 962998 µs
<6>3429958-[INFO] instr: 0 / mips: 0.0000 / / finds: 1
<6>3429958-[INFO] etime: 46689568 ns / ctime: 3194700 ns / %util: 6.84 / files: 0
<6>3429958-[INFO] calls: PCHA=1 PCHC=1 PCHD=4 PCHK=1 UCP1=1 UGT1=1
<6>3429958-[INFO] mk.seg PCHA PCHC PCHD PCHK UCP1 UGT1
<6>3429958-[INFO] sysexit: Closing pg_conn_tty connection
[shc_user@cucmtpccu1 ~]$ export PGHOST=cucmpsgsu0.postgres.database.azure.com
[shc_user@cucmtpccu1 ~]$ export PGDATABASE=mshcd
[shc_user@cucmtpccu1 ~]$ export PGUSER=shc_uadmin
[shc_user@cucmtpccu1 ~]$ export PGPASSWORD=abc123
[shc_user@cucmtpccu1 ~]$ export PGOPTIONS='--search_path=shc,shc_tty,public'
[shc_user@cucmtpccu1 ~]$ .nix-profile/bin/test 'K-T-*' -q
<6>3343433-[INFO] BUILD_TAG = jenkins-Tpfasmbuild1-514
<6>3343433-[INFO] sql_tty_connect_db: tty_conninfo:'dbname=shc_tty_data'
<6>3343433-[INFO] process_name=10.166.29.36#3343433
<7>3343433---------------------------------------------------------
<7>3343433- Using PostgreSQL database
<7>3343433---------------------------------------------------------
<7>3343433-SQL_init_db_connection() conninfo=dbname=shc_data
<7>3343433-SQL_init_db_connection() Connection to shc_data database SUCCESSFUL
<6>3343433-[INFO] PostgreSQL Server Version = 1500.4 protocol 3
<7>3343433-SQL_init_db_connection() PREPARE AdvisoryLockData PQresultStatus = PGRES_COMMAND_OK
<7>3343433-SQL_init_db_connection() PREPARE AdvisoryUnLockData PQresultStatus = PGRES_COMMAND_OK
<7>3343433-SQL_init_db_connection() PREPARE SelectSize PQresultStatus = PGRES_COMMAND_OK
<7>3343433-SQL_init_db_connection() PREPARE SelectData PQresultStatus = PGRES_COMMAND_OK
<7>3343433-SQL_init_db_connection() PREPARE InsertData PQresultStatus = PGRES_COMMAND_OK
<7>3343433-SQL_init_db_connection() PREPARE UpdateData PQresultStatus = PGRES_COMMAND_OK
<7>3343433-loading builtin FACE
<7>3343433-loading builtin FMSG
<7>3343433-loading builtin FMLG
<7>3343433-loading builtin UII1
<7>3343433-loading builtin UIO1
<7>3343433-loading builtin UIM1
<7>3343433-loading builtin UIY3
<7>3343433-loading builtin UIY2
<7>3343433-loading builtin UIY1
<7>3343433-loading builtin UIZ1
<7>3343433-loading builtin WGA1
<7>3343433-loading builtin COPA
<7>3343433-loading builtin HCVT
<7>3343433-loading builtin HTEA
<7>3343433-loading builtin WGR1
<7>3343433-loading builtin UGK6
<7>3343433-loading builtin UGK7
<7>3343433-loading builtin CVFG
<7>3343433-loading builtin GMI9
<7>3343433-loading builtin HLOG
<7>3343433-loading builtin GMI8
<7>3343433-loading builtin UMA1
<7>3343433-loading builtin UMD1
<7>3343433-loading builtin UMS1
<7>3343433-loading builtin UGI1
<7>3343433-loading builtin HTCZ
<7>3343433-loading builtin C000
<7>3343433-loading builtin HRD4
<7>3343433-loading builtin HTCY
<4>3343433-[WARN] init_globals() not fully unimplemented
<7>3343433-init_globals() load_core_resident
<4>3343433-[WARN] Init dbref_SW05SR
<4>3343433-[WARN] Init dbref_SR05SR
<4>3343433-[WARN] Init dbref_GW01SR
<4>3343433-[WARN] Init dbref_SEQ0SW
<4>3343433-[WARN] Init dbref_FFQ0SW
<4>3343433-[WARN] Init dbref_PNR0SW
<7>3343433-init_pool()
<7>3343433-/fs-data/POOL.DAT file already exists
<7>3343433-getFreeFileAddr()
<7>3343433-getActiveTape()
<7>3343433-1 tuples returned
<7>3343433-getActiveTape()
<7>3343433-1 tuples returned
<7>3343433-getActiveTape()
<7>3343433-1 tuples returned
<7>3343433-initializing segment DRIV transfer vector
<7>3343433-initializing tvp[0]=DRV1 nmix=642637 tsv=1
<7>3343433-initializing tvp[1]=DRV2 nmix=642638 tsv=2
<7>3343433-initializing tvp[2]=DRV3 nmix=642639 tsv=3
<7>3343433-initializing tvp[3]=DRV4 nmix=642640 tsv=4
<7>3343433-initializing tvp[4]=DRV5 nmix=642641 tsv=5
<7>3343433-initializing tvp[5]=DRV6 nmix=642642 tsv=6
<7>3343433-initializing tvp[6]=DRV7 nmix=642643 tsv=7
<7>3343433-initializing tvp[7]=DRV8 nmix=642644 tsv=8
<7>3343433-initializing tvp[8]=DRV9 nmix=642645 tsv=9
<7>3343433-initializing tvp[9]=DRVA nmix=642646 tsv=10
<7>3343433-initializing tvp[10]=DRVB nmix=642647 tsv=11
<7>3343433-initializing tvp[11]=DRVC nmix=642648 tsv=12
<7>3343433-initializing tvp[12]=DRVD nmix=642649 tsv=13
<7>3343433-initializing tvp[13]=DRVE nmix=642650 tsv=14
<7>3343433-initializing segment EWE0 transfer vector
<7>3343433-initializing tvp[0]=EWEX nmix=695193 tsv=1
<7>3343433-initializing tvp[1]=EWEY nmix=695194 tsv=2
<7>3343433-initializing tvp[2]=EWEZ nmix=695195 tsv=3
<7>3343433-initializing segment EWF1 transfer vector
<7>3343433-initializing tvp[0]=EWFB nmix=695207 tsv=1
<7>3343433-initializing segment EWP3 transfer vector
<7>3343433-initializing tvp[0]=EWPA nmix=695566 tsv=1
<7>3343433-initializing segment IRB1 transfer vector
<7>3343433-initializing tvp[0]=IRB2 nmix=875198 tsv=1
<7>3343433-initializing tvp[1]=IRB3 nmix=875199 tsv=2
<7>3343433-initializing tvp[2]=IRB4 nmix=875200 tsv=3
<7>3343433-initializing tvp[3]=IRB5 nmix=875201 tsv=4
<7>3343433-initializing tvp[4]=IRB6 nmix=875202 tsv=5
<7>3343433-initializing tvp[5]=IRB7 nmix=875203 tsv=6
<7>3343433-initializing tvp[6]=IRB8 nmix=875204 tsv=7
<7>3343433-initializing tvp[7]=IRB9 nmix=875205 tsv=8
<7>3343433-initializing tvp[8]=IRBA nmix=875206 tsv=9
<7>3343433-initializing tvp[9]=IRBB nmix=875207 tsv=10
<7>3343433-initializing tvp[10]=IRBC nmix=875208 tsv=11
<7>3343433-initializing tvp[11]=IRBD nmix=875209 tsv=12
<7>3343433-initializing tvp[12]=IRBE nmix=875210 tsv=13
<7>3343433-initializing tvp[13]=IRBF nmix=875211 tsv=14
<7>3343433-initializing segment IRF1 transfer vector
<7>3343433-initializing tvp[0]=IRFA nmix=875350 tsv=1
<7>3343433-initializing segment IRO1 transfer vector
<7>3343433-initializing tvp[0]=IRO2 nmix=875666 tsv=1
<7>3343433-initializing tvp[1]=IRO3 nmix=875667 tsv=2
<7>3343433-initializing segment IRS1 transfer vector
<7>3343433-initializing tvp[0]=IRS2 nmix=875810 tsv=1
<7>3343433-initializing tvp[1]=IRS3 nmix=875811 tsv=2
<7>3343433-initializing segment KCD8 transfer vector
<7>3343433-initializing tvp[0]=KCDC nmix=949152 tsv=1
<7>3343433-initializing segment KKV1 transfer vector
<7>3343433-initializing tvp[0]=KKVA nmix=960166 tsv=1
<7>3343433-initializing segment NFA7 transfer vector
<7>3343433-initializing tvp[0]=NFAZ nmix=1092923 tsv=1
<7>3343433-initializing segment NFD4 transfer vector
<7>3343433-initializing tvp[0]=NFDA nmix=1093006 tsv=1
<7>3343433-initializing segment PQD4 transfer vector
<7>3343433-initializing tvp[0]=PQD5 nmix=1200569 tsv=1
<7>3343433-initializing tvp[1]=PQD6 nmix=1200570 tsv=2
<7>3343433-initializing segment PQV5 transfer vector
<7>3343433-initializing tvp[0]=PQV6 nmix=1201218 tsv=1
<7>3343433-initializing tvp[1]=PQV7 nmix=1201219 tsv=2
<7>3343433-initializing segment PRE6 transfer vector
<7>3343433-initializing tvp[0]=PREZ nmix=1201931 tsv=1
<7>3343433-initializing segment SAB0 transfer vector
<7>3343433-initializing tvp[0]=S1B0 nmix=1308060 tsv=1
<7>3343433-initializing segment SAB4 transfer vector
<7>3343433-initializing tvp[0]=S1B4 nmix=1308064 tsv=1
<7>3343433-initializing segment SAED transfer vector
<7>3343433-initializing tvp[0]=S1ED nmix=1308181 tsv=1
<7>3343433-initializing tvp[1]=S2ED nmix=1309477 tsv=2
<7>3343433-initializing tvp[2]=S3ED nmix=1310773 tsv=3
<7>3343433-initializing segment SAF2 transfer vector
<7>3343433-initializing tvp[0]=S1F2 nmix=1308206 tsv=1
<7>3343433-initializing segment SAI1 transfer vector
<7>3343433-initializing tvp[0]=S1I1 nmix=1308313 tsv=1
<7>3343433-initializing tvp[1]=S2I1 nmix=1309609 tsv=2
<7>3343433-initializing segment SAI4 transfer vector
<7>3343433-initializing tvp[0]=S1I4 nmix=1308316 tsv=1
<7>3343433-initializing tvp[1]=S2I4 nmix=1309612 tsv=2
<7>3343433-initializing tvp[2]=S3I4 nmix=1310908 tsv=3
<7>3343433-initializing segment SAI7 transfer vector
<7>3343433-initializing tvp[0]=S1I7 nmix=1308319 tsv=1
<7>3343433-initializing tvp[1]=S2I7 nmix=1309615 tsv=2
<7>3343433-initializing segment SAM2 transfer vector
<7>3343433-initializing tvp[0]=S1M2 nmix=1308458 tsv=1
<7>3343433-initializing segment SASX transfer vector
<7>3343433-initializing tvp[0]=S1SX nmix=1308705 tsv=1
<7>3343433-initializing segment TIK3 transfer vector
<7>3343433-initializing tvp[0]=TIKA nmix=1377082 tsv=1
<7>3343433-initializing segment TOQ1 transfer vector
<7>3343433-initializing tvp[0]=TOQA nmix=1385074 tsv=1
<7>3343433-initializing segment TOS1 transfer vector
<7>3343433-initializing tvp[0]=TOSA nmix=1385146 tsv=1
<7>3343433-initializing tvp[1]=TOSB nmix=1385147 tsv=2
<7>3343433-initializing tvp[2]=TOSC nmix=1385148 tsv=3
<7>3343433-initializing tvp[3]=TOSD nmix=1385149 tsv=4
<7>3343433-initializing segment UCC3 transfer vector
<7>3343433-initializing tvp[0]=UCCA nmix=1415674 tsv=1
<7>3343433-initializing segment UCL1 transfer vector
<7>3343433-initializing tvp[0]=U1L1 nmix=1401733 tsv=1
<7>3343433-initializing tvp[1]=U2L1 nmix=1403029 tsv=2
<7>3343433-initializing segment UL11 transfer vector
<7>3343433-initializing tvp[0]=UL12 nmix=1426934 tsv=1
<7>3343433-initializing segment WIM1 transfer vector
<7>3343433-initializing tvp[0]=WIMZ nmix=1517147 tsv=1
<7>3343433-initializing segment WIM2 transfer vector
<7>3343433-initializing tvp[0]=WIMA nmix=1517122 tsv=1
<7>3343433-initializing segment EWF2 transfer vector
<7>3343433-initializing tvp[0]=EWFA nmix=695206 tsv=1
<7>3343433-initializing segment ICC1 transfer vector
<7>3343433-initializing tvp[0]=ICCA nmix=855802 tsv=1
<7>3343433-initializing segment KDH0 transfer vector
<7>3343433-initializing tvp[0]=KDHA nmix=950590 tsv=1
<7>3343433-initializing segment KUU0 transfer vector
<7>3343433-initializing tvp[0]=KUUM nmix=973102 tsv=1
<7>3343433-initializing tvp[1]=KUUN nmix=973103 tsv=2
<7>3343433-initializing segment PTJ5 transfer vector
<7>3343433-initializing tvp[0]=PTJB nmix=1204679 tsv=1
<7>3343433-initializing tvp[1]=PTJC nmix=1204680 tsv=2
<7>3343433-initializing segment RIQ3 transfer vector
<7>3343433-initializing tvp[0]=RIQ9 nmix=1283985 tsv=1
<7>3343433-initializing segment SAA0 transfer vector
<7>3343433-initializing tvp[0]=S1A0 nmix=1308024 tsv=1
<7>3343433-initializing tvp[1]=S2A0 nmix=1309320 tsv=2
<7>3343433-initializing segment SAA4 transfer vector
<7>3343433-initializing tvp[0]=S1A4 nmix=1308028 tsv=1
<7>3343433-initializing segment SAAA transfer vector
<7>3343433-initializing tvp[0]=S1AA nmix=1308034 tsv=1
<7>3343433-initializing tvp[1]=S2AA nmix=1309330 tsv=2
<7>3343433-initializing tvp[2]=S3AA nmix=1310626 tsv=3
<7>3343433-initializing segment SAC5 transfer vector
<7>3343433-initializing tvp[0]=S1C5 nmix=1308101 tsv=1
<7>3343433-initializing tvp[1]=S2C5 nmix=1309397 tsv=2
<7>3343433-initializing tvp[2]=S3C5 nmix=1310693 tsv=3
<7>3343433-initializing segment SAC6 transfer vector
<7>3343433-initializing tvp[0]=S1C6 nmix=1308102 tsv=1
<7>3343433-initializing segment SACA transfer vector
<7>3343433-initializing tvp[0]=S1CA nmix=1308106 tsv=1
<7>3343433-initializing segment SAF1 transfer vector
<7>3343433-initializing tvp[0]=S1F1 nmix=1308205 tsv=1
<7>3343433-initializing tvp[1]=S2F1 nmix=1309501 tsv=2
<7>3343433-initializing tvp[2]=S3F1 nmix=1310797 tsv=3
<7>3343433-initializing tvp[3]=S4F1 nmix=1312093 tsv=4
<7>3343433-initializing segment SAF3 transfer vector
<7>3343433-initializing tvp[0]=S1F3 nmix=1308207 tsv=1
<7>3343433-initializing segment SAF4 transfer vector
<7>3343433-initializing tvp[0]=S1F4 nmix=1308208 tsv=1
<7>3343433-initializing segment SAF6 transfer vector
<7>3343433-initializing tvp[0]=S1F6 nmix=1308210 tsv=1
<7>3343433-initializing segment SAF8 transfer vector
<7>3343433-initializing tvp[0]=S1F8 nmix=1308212 tsv=1
<7>3343433-initializing segment SAF9 transfer vector
<7>3343433-initializing tvp[0]=S1F9 nmix=1308213 tsv=1
<7>3343433-initializing segment SAI8 transfer vector
<7>3343433-initializing tvp[0]=S1I8 nmix=1308320 tsv=1
<7>3343433-initializing tvp[1]=S2I8 nmix=1309616 tsv=2
<7>3343433-initializing tvp[2]=S3I8 nmix=1310912 tsv=3
<7>3343433-initializing segment SAIB transfer vector
<7>3343433-initializing tvp[0]=S1IB nmix=1308323 tsv=1
<7>3343433-initializing tvp[1]=S2IB nmix=1309619 tsv=2
<7>3343433-initializing segment SAIC transfer vector
<7>3343433-initializing tvp[0]=S1IC nmix=1308324 tsv=1
<7>3343433-initializing segment SAM3 transfer vector
<7>3343433-initializing tvp[0]=S1M3 nmix=1308459 tsv=1
<7>3343433-initializing segment SAR5 transfer vector
<7>3343433-initializing tvp[0]=S1R5 nmix=1308641 tsv=1
<7>3343433-initializing tvp[1]=S2R5 nmix=1309937 tsv=2
<7>3343433-initializing segment SAS2 transfer vector
<7>3343433-initializing tvp[0]=S1S2 nmix=1308674 tsv=1
<7>3343433-initializing segment SAS6 transfer vector
<7>3343433-initializing tvp[0]=S1S6 nmix=1308678 tsv=1
<7>3343433-initializing segment SAS9 transfer vector
<7>3343433-initializing tvp[0]=S1S9 nmix=1308681 tsv=1
<7>3343433-initializing segment SASD transfer vector
<7>3343433-initializing tvp[0]=S1SD nmix=1308685 tsv=1
<7>3343433-initializing segment SASE transfer vector
<7>3343433-initializing tvp[0]=S1SE nmix=1308686 tsv=1
<7>3343433-initializing tvp[1]=S2SE nmix=1309982 tsv=2
<7>3343433-initializing tvp[2]=S3SE nmix=1311278 tsv=3
<7>3343433-initializing tvp[3]=S4SE nmix=1312574 tsv=4
<7>3343433-initializing segment SASG transfer vector
<7>3343433-initializing tvp[0]=S1SG nmix=1308688 tsv=1
<7>3343433-initializing tvp[1]=S2SG nmix=1309984 tsv=2
<7>3343433-initializing tvp[2]=S3SG nmix=1311280 tsv=3
<7>3343433-initializing segment SASW transfer vector
<7>3343433-initializing tvp[0]=S1SW nmix=1308704 tsv=1
<7>3343433-initializing segment SAZU transfer vector
<7>3343433-initializing tvp[0]=S1ZU nmix=1308954 tsv=1
<7>3343433-initializing segment SPR0 transfer vector
<7>3343433-initializing tvp[0]=SPR1 nmix=1339741 tsv=1
<7>3343433-initializing segment TOC3 transfer vector
<7>3343433-initializing tvp[0]=TOCA nmix=1384570 tsv=1
<7>3343433-initializing segment TOE8 transfer vector
<7>3343433-initializing tvp[0]=TOEA nmix=1384642 tsv=1
<7>3343433-initializing segment TOS2 transfer vector
<7>3343433-initializing tvp[0]=TOSE nmix=1385150 tsv=1
<7>3343433-initializing segment WIN1 transfer vector
<7>3343433-initializing tvp[0]=WINA nmix=1517158 tsv=1
<7>3343433-initializing segment WINB transfer vector
<7>3343433-initializing tvp[0]=WINH nmix=1517165 tsv=1
<7>3343433-initializing segment SAC9 transfer vector
<7>3343433-initializing tvp[0]=S1C9 nmix=1308105 tsv=1
<7>3343433-initializing tvp[1]=S2C9 nmix=1309401 tsv=2
<7>3343433-initializing tvp[2]=S3C9 nmix=1310697 tsv=3
<7>3343433-msginit() LNIATA = F66000
<6>3343433-[INFO] process_termdefn() unimplemented
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(16146432)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-init_aaa WA0VED=00
<7>3343433-Entry type 00/Non-RPC entry
<7>3343433-call_appl_entry WA0ROL=0000
<7>3343433-call_appl_entry WA0VED=00
<7>3343433-CAPIC(action=S,capeq=0)
<7>3343433-call_appl_entry entering UGT1
<7>3343433-1: entering segment UGT1
<7>3343433-1: entering segment PCHA
<6>3343433-[INFO] LEVTA(0) returning 1
<6>3343433-[INFO] LEVTA(1) returning 1
<7>3343433-1: entering segment PCHC
<6>3343433-[INFO] LEVTA(0) returning 1
<7>3343433-1: entering segment PCHK
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(-335504555)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-2: entering segment PCHD
<7>3343433-3: entering segment UCP1
<7>3343433-BACKC to 2: PCHD
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-BACKC to 1: PCHK
<7>3343433-2: entering segment PCHD
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-BACKC to 1: PCHK
<7>3343433-2: entering segment PCHD
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-BACKC to 1: PCHK
<7>3343433-2: entering segment PCHD
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-BACKC to 1: PCHK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] DBADD: ALG not available, treating SR05SR as work record and creating pool file
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<7>3343433-get_pool_fa()
<4>3343433-[WARN] No File_address is found with status=free
<3>3343433-[ERROR] SELECT nextval Failed [../tpfasm.c:3561:get_pool_fa]
<7>3343433-ROLLBACK TRANSACTION
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(0)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<4>3343433-[WARN] No PKY in keys for DBRED
<7>3343433-SQL_get_tpf_rw() SelectDataCommand = CALL SQL_select_data_procedure($1, $2, NULL, NULL) hold(0) fa(-968833847)
<7>3343433-SQL_get_tpf_rw() SelectDataNParams = 2
<7>3343433-SQL_get_tpf_rw() res = PGRES_TUPLES_OK
<3>3343433-[ERROR] SELECT failed: NO ROWS RETURNED [../tpfasm.c:4826:SQL_get_tpf_rw]
<3>3343433-[ERROR] INVALID_FILE_ADDRESS C640C4C9 [../tpfasm.c:4829:SQL_get_tpf_rw]
<6>3343433-[INFO] missing data: c640c4c9
<7>3343433-SQL_put_tpf_rw() UpdateDataCommand = CALL SQL_update_data_procedure($1, $2, $3) unhold(0) fa(0)
<7>3343433-SQL_put_tpf_rw() UpdateDataNParams = 3
=================================================================
==3343433==ERROR: AddressSanitizer: heap-buffer-overflow on address 0xf337ba80 at pc 0xf795fcdd bp 0xff8a74d8 sp 0xff8a70b0
READ of size 4096 at 0xf337ba80 thread T0
#0 0xf795fcdc in __interceptor_memcpy (/nix/store/3blqv6wzmwqgkkw45i6c8w0bkwldk418-gcc-12.2.0-lib/lib/libasan.so.8+0x42cdc)
#1 0xf78c34bb in pqPutnchar (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x174bb)
#2 0xf78be05e in PQsendQueryGuts (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x1205e)
#3 0xf78c05a2 in PQexecPrepared (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x145a2)
#4 0x808e209 in SQL_put_tpf_rw ../tpfasm.c:4025
#5 0x808f607 in put_tpf_rw ../tpfasm.c:4626
#6 0x812e389 in initialize_subfile_or_fullfile ../tpfdf_tpf.c:6525
#7 0x81641c7 in DBDSP ../tpfdf_tpf.c:3626
#8 0xf4cd7ef6 in _segPCHK /app/build/pchk.c:19258
#9 0x80cc94b in call_segment ../tpfasm.c:2590
#10 0x80cd9ce in ENTNC ../tpfasm.c:2946
#11 0xf4cdee13 in _segPCHC /app/build/pchc.c:24217
#12 0x80cc94b in call_segment ../tpfasm.c:2590
#13 0x80cd9ce in ENTNC ../tpfasm.c:2946
#14 0xf4ce6f1c in _segPCHA /app/build/pcha.c:23851
#15 0x80cc94b in call_segment ../tpfasm.c:2590
#16 0x80cd9ce in ENTNC ../tpfasm.c:2946
#17 0xf4cee5fc in _segUGT1 /app/build/ugt1.c:22579
#18 0x80cc94b in call_segment ../tpfasm.c:2590
#19 0x81146a4 in call_appl_entry ../tpfasm.c:2544
#20 0x80621fd in extest src/test.c:90
#21 0x8060da5 in main src/test.c:285
#22 0xf6c6b808 in __libc_start_call_main (/nix/store/d1d4bpkj53br0bsdz1ksgar71wa7zc7i-glibc-2.37-45/lib/libc.so.6+0x1f808)
#23 0xf6c6b8cb in __libc_start_main_alias_2 (/nix/store/d1d4bpkj53br0bsdz1ksgar71wa7zc7i-glibc-2.37-45/lib/libc.so.6+0x1f8cb)
#24 0x80620db in _start (/nix/store/4s99ss66gfja6pnf41smbvnhvg6c48kf-shares-c-0.0.1/bin/test+0x80620db)
0xf337ba80 is located 0 bytes to the right of 2048-byte region [0xf337b280,0xf337ba80)
allocated by thread T0 here:
#0 0xf79db00b in __interceptor_malloc (/nix/store/3blqv6wzmwqgkkw45i6c8w0bkwldk418-gcc-12.2.0-lib/lib/libasan.so.8+0xbe00b)
#1 0xf78bd04c in pqResultAlloc (/nix/store/glkv3qv4y64xigwpjcwflp3ni2anjma0-postgresql-14.9-lib/lib/libpq.so.5+0x1104c)
SUMMARY: AddressSanitizer: heap-buffer-overflow (/nix/store/3blqv6wzmwqgkkw45i6c8w0bkwldk418-gcc-12.2.0-lib/lib/libasan.so.8+0x42cdc) in __interceptor_memcpy
Shadow bytes around the buggy address:
0x3e66f700: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0x3e66f710: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0x3e66f720: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0x3e66f730: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
0x3e66f740: 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00
=>0x3e66f750:[fa]fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
0x3e66f760: fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
0x3e66f770: fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
0x3e66f780: fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
0x3e66f790: fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
0x3e66f7a0: fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa fa
Shadow byte legend (one shadow byte represents 8 application bytes):
Addressable: 00
Partially addressable: 01 02 03 04 05 06 07
Heap left redzone: fa
Freed heap region: fd
Stack left redzone: f1
Stack mid redzone: f2
Stack right redzone: f3
Stack after return: f5
Stack use after scope: f8
Global redzone: f9
Global init order: f6
Poisoned by user: f7
Container overflow: fc
Array cookie: ac
Intra object redzone: bb
ASan internal: fe
Left alloca redzone: ca
Right alloca redzone: cb
==3343433==ABORTING
[shc_user@cucmtpccu1 ~]$
