Hi,
I've successfully compiled and installed tds_fdw but I'm getting an odd error when I try to access a foreign table.
sas=# create server sybase foreign data wrapper tds_fdw options (servername '10.15.2.70', port '5000');
CREATE SERVER
sas=# create user mapping for postgres server sybase options (username 'sa', password 'not1common');
CREATE USER MAPPING
sas=# create foreign table if not exists sybase_table ("ApiSessionId" bigint,"ApiSessionRemoteId" bigint,"ApiSessionCreatorUID" character varying(32),"ApiSessionUserNotes" text,"ApiSessionModNotes" text,"ApiSessionIsDeleted" boolean,"AdministratorLoginId" bigint,"MeetingSessionId" bigint) server sybase options(database 'sas_db', query 'select * from web_app.ApiSession');
CREATE FOREIGN TABLE
sas=# select * from sybase_table limit 1;
NOTICE: DB-Library notice: Msg #: 5701, Msg state: 2, Msg: Changed database context to 'master'.
, Server: vastg_db, Process: , Line: 0, Level: 0
NOTICE: DB-Library notice: Msg #: 5701, Msg state: 1, Msg: Changed database context to 'sas_db'.
, Server: vastg_db, Process: , Line: 1, Level: 0
NOTICE: DB-Library notice: Msg #: 5701, Msg state: 2, Msg: Changed database context to 'master'.
, Server: vastg_db, Process: , Line: 0, Level: 0
NOTICE: DB-Library notice: Msg #: 5701, Msg state: 1, Msg: Changed database context to 'sas_db'.
, Server: vastg_db, Process: , Line: 1, Level: 0
ERROR: invalid input syntax for integer: ""
Here's the freetds log of this transaction. In the tcpdump-like section you can read the data for that record, and at least the second column is correct.
postgres@bitarena:~$ cat /tmp/freetds.log
15:45:51.071682 34287 (log.c:196):Starting log file for FreeTDS 0.91
on 2014-05-28 15:45:51 with debug flags 0xffff.
15:45:51.071736 34287 (iconv.c:330):tds_iconv_open(0x7f4ae5eccf70, UTF-8)
15:45:51.071925 34287 (iconv.c:187):local name for ISO-8859-1 is ISO-8859-1
15:45:51.071943 34287 (iconv.c:187):local name for UTF-8 is UTF-8
15:45:51.071951 34287 (iconv.c:187):local name for UCS-2LE is UCS-2LE
15:45:51.071959 34287 (iconv.c:187):local name for UCS-2BE is UCS-2BE
15:45:51.071967 34287 (iconv.c:349):setting up conversions for client charset "UTF-8"
15:45:51.071974 34287 (iconv.c:351):preparing iconv for "UTF-8" <-> "UCS-2LE" conversion
15:45:51.071992 34287 (iconv.c:391):preparing iconv for "ISO-8859-1" <-> "ISO-8859-1" conversion
15:45:51.072001 34287 (iconv.c:394):tds_iconv_open: done
15:45:51.072018 34287 (net.c:205):Connecting to 10.15.2.70 port 5000 (TDS version 4.2)
15:45:51.072229 34287 (net.c:270):tds_open_socket: connect(2) returned "Operation now in progress"
15:45:51.187342 34287 (net.c:310):tds_open_socket() succeeded
15:45:51.187427 34287 (util.c:156):Changed query state from DEAD to IDLE
15:45:51.187457 34287 (net.c:741):Sending packet
0000 02 00 02 00 00 00 00 00-62 69 74 61 72 65 6e 61 |........ bitarena|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0020 00 00 00 00 00 00 08 73-61 00 00 00 00 00 00 00 |.......s a.......|
0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0040 00 00 00 00 00 02 6e 6f-74 31 63 6f 6d 6d 6f 6e |......no t1common|
0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0060 00 00 00 00 0a 33 34 32-38 37 00 00 00 00 00 00 |.....342 87......|
0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........|
0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00b0 00 00 00 31 30 2e 31 35-2e 32 2e 37 30 3a 35 30 |...10.15 .2.70:50|
00c0 30 30 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |00...... ........|
00d0 00 0f 6e 6f 74 31 63 6f-6d 6d 6f 6e 00 00 00 00 |..not1co mmon....|
00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01d0 00 0a 04 02 00 00 44 42-2d 4c 69 62 72 61 72 79 |......DB -Library|
01e0 0a 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli|
01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........|
15:45:51.187751 34287 (net.c:741):Sending packet
0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 75 74 66 |........ .....utf|
0020 38 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |8....... ........|
0030 00 00 00 00 00 00 00 00-00 00 00 04 01 35 31 32 |........ .....512|
0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....|
15:45:51.187930 34287 (token.c:328):tds_process_login_tokens()
15:45:51.314519 34287 (net.c:555):Received header
0000 04 01 00 70 00 00 00 00- |...p....|
15:45:51.314647 34287 (net.c:609):Received packet
0000 04 01 00 70 00 00 00 00-e3 0f 00 01 06 6d 61 73 |...p.... .....mas|
0010 74 65 72 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |ter.mast er.:.E..|
0020 00 02 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 6d 61 73 74 65 72-27 2e 0a 08 76 61 73 74 | 'master '...vast|
0050 67 5f 64 62 00 00 00 ad-0d 00 01 04 02 00 00 03 |g_db.... ........|
0060 41 53 45 0f 07 00 00 fd-00 00 02 00 33 00 00 00 |ASE..... ....3...|
15:45:51.314718 34287 (token.c:337):looking for login token, got e3(ENVCHANGE)
15:45:51.314742 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.314774 34287 (dblib.c:327):db_env_chg(0x7f4ae5eccf70, 1, master, master)
15:45:51.314792 34287 (token.c:337):looking for login token, got ab(INFO)
15:45:51.314803 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.314814 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.314831 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.314843 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5dd7d70, 0x7f4ae5eccf70, 0x7ffffe5d8df0)
15:45:51.314854 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'master'.
"
15:45:51.315037 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.315059 34287 (token.c:337):looking for login token, got ad(LOGINACK)
15:45:51.315071 34287 (token.c:373):server reports TDS version 4.2.0.0
15:45:51.315083 34287 (token.c:375):Product name for 0x4020000 is unknown
15:45:51.315096 34287 (token.c:337):looking for login token, got fd(DONE)
15:45:51.315106 34287 (token.c:122):tds_process_default_tokens() marker is fd(DONE)
15:45:51.315122 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.315135 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.315145 34287 (token.c:2370): rows_affected = 51
15:45:51.315156 34287 (token.c:438):tds_process_login_tokens() returning TDS_SUCCEED
15:45:51.315178 34287 (mem.c:615):tds_free_all_results()
15:45:51.315190 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.315205 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.315216 34287 (net.c:741):Sending packet
0000 01 01 00 1b 00 00 00 00-73 65 74 20 74 65 78 74 |........ set text|
0010 73 69 7a 65 20 36 34 35-31 32 20 |size 645 12 |
15:45:51.315386 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d8f28, 0x7ffffe5d8f2c, 0x100)
15:45:51.315413 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.426652 34287 (net.c:555):Received header
0000 04 01 00 11 00 00 00 00- |........|
15:45:51.426750 34287 (net.c:609):Received packet
0000 04 01 00 11 00 00 00 00-fd 00 00 02 00 00 00 00 |........ ........|
0010 00 - |.|
15:45:51.426776 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:51.426792 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.426804 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.426815 34287 (util.c:156):Changed query state from READING to IDLE
15:45:51.426826 34287 (token.c:2370): rows_affected = 0
15:45:51.426837 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:51.426847 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d8f28, 0x7ffffe5d8f2c, 0x100)
15:45:51.426859 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:51.426875 34287 (dblib.c:239):dblib_add_connection(0x7f4ad67d0760, 0x7f4ae5eccf70)
15:45:51.426892 34287 (dblib.c:1398):dbuse(0x7f4ae5dd5f50, sas_db)
15:45:51.426907 34287 (dblib.c:1312):dbcmd(0x7f4ae5dd5f50, use [sas_db])
15:45:51.426927 34287 (dblib.c:1319):dbcmd() bufsz = 0
15:45:51.426936 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5dd5f50)
15:45:51.426977 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5dd5f50)
15:45:51.426988 34287 (mem.c:615):tds_free_all_results()
15:45:51.426996 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.427005 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.427013 34287 (net.c:741):Sending packet
0000 01 01 00 14 00 00 00 00-75 73 65 20 5b 73 61 73 |........ use [sas|
0010 5f 64 62 5d - |_db]|
15:45:51.427191 34287 (dblib.c:4639):dbsqlok(0x7f4ae5dd5f50)
15:45:51.427211 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:51.427219 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d9388, 0x7ffffe5d938c, 0x6914)
15:45:51.427228 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.541554 34287 (net.c:555):Received header
0000 04 01 00 60 00 00 00 00- |...`....|
15:45:51.541627 34287 (net.c:609):Received packet
0000 04 01 00 60 00 00 00 00-e3 0f 00 01 06 73 61 73 |...`.... .....sas|
0010 5f 64 62 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |_db.mast er.:.E..|
0020 00 01 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 73 61 73 5f 64 62-27 2e 0a 08 76 61 73 74 | 'sas_db '...vast|
0050 67 5f 64 62 00 01 00 fd-00 00 02 00 00 00 00 00 |g_db.... ........|
15:45:51.541673 34287 (token.c:555):processing result tokens. marker is e3(ENVCHANGE)
15:45:51.541683 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.541695 34287 (dblib.c:327):db_env_chg(0x7f4ae5eccf70, 1, master, sas_db)
15:45:51.541706 34287 (token.c:555):processing result tokens. marker is ab(INFO)
15:45:51.541714 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.541722 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.541733 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.541741 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5dd7d70, 0x7f4ae5eccf70, 0x7ffffe5d91e0)
15:45:51.541750 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'sas_db'.
"
15:45:51.542038 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.542067 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:51.542078 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.542087 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.542094 34287 (util.c:156):Changed query state from READING to IDLE
15:45:51.542102 34287 (token.c:2370): rows_affected = 0
15:45:51.542109 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:51.542125 34287 (dblib.c:4707):dbsqlok() end status is SUCCEED
15:45:51.542134 34287 (dblib.c:4718):dbsqlok() end status was success
15:45:51.542144 34287 (dblib.c:1668):dbresults(0x7f4ae5dd5f50)
15:45:51.542153 34287 (dblib.c:1674):dbresults: dbresults_state is 5 (_DB_RES_SUCCEED)
15:45:51.542161 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:51.542169 34287 (dblib.c:5854):dbcanquery(0x7f4ae5dd5f50)
15:45:51.542176 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93ac, (nil), 0x108)
15:45:51.542222 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:51.542232 34287 (dblib.c:1312):dbcmd(0x7f4ae5dd5f50, select * from web_app.ApiSession)
15:45:51.542240 34287 (dblib.c:1319):dbcmd() bufsz = 13
15:45:51.542247 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5dd5f50)
15:45:51.542255 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5dd5f50)
15:45:51.542263 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5dd5f50)
15:45:51.542272 34287 (mem.c:615):tds_free_all_results()
15:45:51.542280 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.542289 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.542297 34287 (net.c:741):Sending packet
0000 01 01 00 28 00 00 00 00-73 65 6c 65 63 74 20 2a |...(.... select *|
0010 20 66 72 6f 6d 20 77 65-62 5f 61 70 70 2e 41 70 | from we b_app.Ap|
0020 69 53 65 73 73 69 6f 6e- |iSession|
15:45:51.542470 34287 (dblib.c:4639):dbsqlok(0x7f4ae5dd5f50)
15:45:51.542490 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:51.542498 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93e8, 0x7ffffe5d93ec, 0x6914)
15:45:51.542507 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.656744 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:51.656815 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-7c 73 0a 69 71 00 00 00 |........ |s.iq...|
0010 00 a0 96 00 0c 41 70 69-53 65 73 73 69 6f 6e 49 |.....Api SessionI|
0020 64 14 41 70 69 53 65 73-73 69 6f 6e 43 72 65 61 |d.ApiSes sionCrea|
0030 74 6f 72 55 49 44 14 41-64 6d 69 6e 69 73 74 72 |torUID.A dministr|
0040 61 74 6f 72 4c 6f 67 69-6e 49 64 10 4d 65 65 74 |atorLogi nId.Meet|
0050 69 6e 67 53 65 73 73 69-6f 6e 49 64 13 41 70 69 |ingSessi onId.Api|
0060 53 65 73 73 69 6f 6e 55-73 65 72 4e 6f 74 65 73 |SessionU serNotes|
0070 12 41 70 69 53 65 73 73-69 6f 6e 4d 6f 64 4e 6f |.ApiSess ionModNo|
0080 74 65 73 13 41 70 69 53-65 73 73 69 6f 6e 49 73 |tes.ApiS essionIs|
0090 44 65 6c 65 74 65 64 12-41 70 69 53 65 73 73 69 |Deleted. ApiSessi|
00a0 6f 6e 52 65 6d 6f 74 65-49 64 a1 60 00 2b 00 00 |onRemote Id.`.+..|
00b0 00 6d 08 23 00 00 00 e1-40 00 00 00 2b 00 00 00 |.m.#.... @...+...|
00c0 6d 08 2b 00 00 00 6d 08-14 00 00 00 22 00 fc 00 |m.+...m. ...."...|
00d0 00 12 00 77 65 62 5f 61-70 70 2e 41 70 69 53 65 |...web_a pp.ApiSe|
00e0 73 73 69 6f 6e 14 00 00-00 22 00 fc 00 00 12 00 |ssion... ."......|
00f0 77 65 62 5f 61 70 70 2e-41 70 69 53 65 73 73 69 |web_app. ApiSessi|
0100 6f 6e 10 00 00 00 32 2b-00 00 00 6d 08 ae 08 00 |on....2+ ...m....|
0110 00 00 00 00 00 00 00 00-d1 08 00 00 00 00 00 00 |........ ........|
0120 f0 3f 2a 00 00 00 62 00-72 00 75 00 63 00 65 00 |.?...b. r.u.c.e.|
0130 73 00 40 00 65 00 6c 00-6c 00 75 00 6d 00 69 00 |[email protected]. l.u.m.i.|
0140 6e 00 61 00 74 00 65 00-2e 00 63 00 6f 00 6d 00 |n.a.t.e. ..c.o.m.|
0150 08 00 00 00 00 28 cd 02-41 08 00 00 00 00 20 de |.....(.. A..... .|
0160 fd 40 10 5a 04 00 00 00-00 00 00 00 00 00 00 eb |[email protected].... ........|
0170 b0 4c 00 00 00 00 00 00-4c b0 eb 02 00 00 00 20 |.L...... L...... |
0180 00 10 5b 04 00 00 00 00-00 00 00 00 00 00 f2 b0 |..[..... ........|
0190 4c 00 00 00 00 00 00 4c-b0 f2 02 00 00 00 20 00 |L......L ...... .|
01a0 01 08 00 00 00 00 00 00-f0 3f d1 08 00 00 00 00 |........ .?......|
01b0 00 00 00 40 2a 00 00 00-62 00 72 00 75 00 63 00 |...@... b.r.u.c.|
01c0 65 00 73 00 40 00 65 00-6c 00 6c 00 75 00 6d 00 |[email protected]. l.l.u.m.|
01d0 69 00 6e 00 61 00 74 00-65 00 2e 00 63 00 6f 00 |i.n.a.t. e...c.o.|
01e0 6d 00 08 00 00 00 00 28-cd 02 41 08 00 00 00 00 |m......( ..A.....|
01f0 30 de fd 40 10 5c 04 00-00 00 00 00 00 00 00 00 |0..@... ........|
15:45:51.656965 34287 (token.c:555):processing result tokens. marker is 7c(PROCID)
15:45:51.656973 34287 (token.c:122):tds_process_default_tokens() marker is 7c(PROCID)
15:45:51.656980 34287 (token.c:555):processing result tokens. marker is a0(COLNAME)
15:45:51.656993 34287 (mem.c:615):tds_free_all_results()
15:45:51.657024 34287 (token.c:555):processing result tokens. marker is a1(COLFMT)
15:45:51.657034 34287 (token.c:1025):processing result. type = 109(float-null), varint_size 1
15:45:51.657042 34287 (token.c:1025):processing result. type = 35(text), varint_size 1
15:45:51.657258 34287 (token.c:3420):adjust_character_column_size:
Server charset: UTF-16LE
Server column_size: 64
Client charset: UTF-8
Client column_size: 128
15:45:51.657274 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657282 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657289 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657296 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657302 34287 (token.c:1025):processing result. type = 98(variant), varint_size 1
15:45:51.657325 34287 (token.c:1025):processing result. type = 65(), varint_size 1
15:45:51.657333 34287 (token.c:1053):NOTE:tds_process_col_fmt: draining 48 bytes
15:45:51.657341 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.657350 34287 (dblib.c:4700):dbsqlok() found result token
15:45:51.657357 34287 (dblib.c:1668):dbresults(0x7f4ae5dd5f50)
15:45:51.657364 34287 (dblib.c:1674):dbresults: dbresults_state is 1 (_DB_RES_RESULTSET_EMPTY)
15:45:51.657371 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93d8, 0x7ffffe5d93dc, 0x6914)
15:45:51.657378 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.657384 34287 (token.c:555):processing result tokens. marker is ae(CONTROL)
15:45:51.657391 34287 (token.c:122):tds_process_default_tokens() marker is ae(CONTROL)
15:45:51.657397 34287 (token.c:237):Eating CONTROL token
15:45:51.657404 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:51.657411 34287 (token.c:666):tds_process_tokens::SET_RETURN stopping on current token
15:45:51.657417 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.657423 34287 (dblib.c:1695):dbresults() tds_process_tokens returned 1 (TDS_SUCCEED),
result_type TDS_ROW_RESULT
15:45:51.657430 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:51.657441 34287 (dblib.c:2018):dbnextrow(0x7f4ae5dd5f50)
15:45:51.657448 34287 (dblib.c:2031):dbnextrow() dbresults_state = 2 (_DB_RES_RESULTSET_ROWS)
15:45:51.657455 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93ec, (nil), 0x1508)
15:45:51.657464 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.657470 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:51.657477 34287 (token.c:2304):tds_process_row(): reading column 0
15:45:51.657483 34287 (token.c:2049):tds_get_data: type 109, varint size 1
15:45:51.657490 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:51.657496 34287 (token.c:2304):tds_process_row(): reading column 1
15:45:51.657502 34287 (token.c:2049):tds_get_data: type 35, varint size 1
15:45:51.657508 34287 (token.c:2110):tds_get_data(): wire column size is 42
15:45:51.657522 34287 (token.c:2304):tds_process_row(): reading column 2
15:45:51.657529 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657535 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:51.657541 34287 (token.c:2304):tds_process_row(): reading column 3
15:45:51.657547 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657553 34287 (token.c:2110):tds_get_data(): wire column size is 109
15:45:51.657560 34287 (token.c:2304):tds_process_row(): reading column 4
15:45:51.657566 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657572 34287 (token.c:2110):tds_get_data(): wire column size is 117
15:45:51.660163 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:51.660215 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-00 fb b0 4c 00 00 00 00 |........ ...L....|
0010 00 00 4c b0 fb 02 00 00-00 20 00 10 5d 04 00 00 |..L..... . ..]...|
0020 00 00 00 00 00 00 00 00-02 b1 4c 00 00 00 00 00 |........ ..L.....|
0030 00 4c b1 02 02 00 00 00-20 00 00 08 00 00 00 00 |.L...... .......|
0040 00 00 00 40 d1 08 00 00-00 00 00 00 08 40 2a 00 |...@.... .....@.|
0050 00 00 62 00 72 00 75 00-63 00 65 00 73 00 40 00 |..b.r.u. c.e.s.@.|
0060 65 00 6c 00 6c 00 75 00-6d 00 69 00 6e 00 61 00 |e.l.l.u. m.i.n.a.|
0070 74 00 65 00 2e 00 63 00-6f 00 6d 00 08 00 00 00 |t.e...c. o.m.....|
0080 00 28 cd 02 41 08 00 00-00 00 40 de fd 40 10 5e |.(..A... ..@..@.^|
0090 04 00 00 00 00 00 00 00-00 00 00 0b b1 4c 00 00 |........ .....L..|
00a0 00 00 00 00 4c b1 0b 02-00 00 00 20 00 10 5f 04 |....L... ... ...|
00b0 00 00 00 00 00 00 00 00-00 00 12 b1 4c 00 00 00 |........ ....L...|
00c0 00 00 00 4c b1 12 02 00-00 00 20 00 00 08 00 00 |...L.... .. .....|
00d0 00 00 00 00 08 40 d1 08-00 00 00 00 00 00 10 40 |.....@.. .......@|
00e0 2a 00 00 00 62 00 72 00-75 00 63 00 65 00 73 00 |_...b.r. u.c.e.s.|
00f0 40 00 65 00 6c 00 6c 00-75 00 6d 00 69 00 6e 00 |@.e.l.l. u.m.i.n.|
0100 61 00 74 00 65 00 2e 00-63 00 6f 00 6d 00 08 00 |a.t.e... c.o.m...|
0110 00 00 00 28 cd 02 41 08-00 00 00 00 40 ab fe 40 |...(..A. ....@..@|
0120 10 80 01 23 00 00 00 00-00 00 00 00 00 1b b1 4c |...#.... .......L|
0130 00 00 00 00 00 00 4c b1-1b 02 00 00 00 20 00 10 |......L. ..... ..|
0140 81 01 23 00 00 00 00 00-00 00 00 00 23 b1 4c 00 |..#..... ....#.L.|
0150 00 00 00 00 00 4c b1 23-02 00 00 00 20 00 00 08 |.....L.# .... ...|
0160 00 00 00 00 00 00 10 40-d1 08 00 00 00 00 00 00 |.......@ ........|
0170 24 40 12 00 00 00 75 00-69 00 67 00 63 00 61 00 |[email protected]. i.g.c.a.|
0180 64 00 6d 00 69 00 6e 00-08 00 00 00 00 68 14 03 |d.m.i.n. .....h..|
0190 41 08 00 00 00 00 18 24-00 41 10 82 01 23 00 00 |A......$ .A...#..|
01a0 00 00 00 00 00 00 00 2b-b1 4c 00 00 00 00 00 00 |.......+ .L......|
01b0 4c b1 2b 02 00 00 00 20-00 10 83 01 23 00 00 00 |L.+.... ....#...|
01c0 00 00 00 00 00 00 32 b1-4c 00 00 00 00 00 00 4c |......2. L......L|
01d0 b1 32 02 00 00 00 20 00-00 08 00 00 00 00 00 00 |.2.... . ........|
01e0 24 40 d1 08 00 00 00 00-00 00 26 40 12 00 00 00 |$@...... ..&@....|
01f0 75 00 69 00 67 00 63 00-61 00 64 00 6d 00 69 00 |u.i.g.c. a.d.m.i.|
15:45:51.660685 34287 (token.c:2304):tds_process_row(): reading column 5
15:45:51.660701 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.660711 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:51.660721 34287 (token.c:2304):tds_process_row(): reading column 6
15:45:51.660731 34287 (token.c:2049):tds_get_data: type 98, varint size 1
15:45:51.660741 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:51.660752 34287 (token.c:2304):tds_process_row(): reading column 7
15:45:51.660763 34287 (token.c:2049):tds_get_data: type 65, varint size 1
15:45:51.660772 34287 (token.c:2110):tds_get_data(): wire column size is 209
15:45:51.660782 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.660799 34287 (buffering.h:306):buffer_transfer_bound_data(0x7f4ae5dd5f60 4040 -1 0x7f4ae5dd5f50 0)
15:45:51.660814 34287 (dblib.c:2100):leaving dbnextrow() returning REG_ROW/MORE_ROWS
15:45:51.660828 34287 (dblib.c:2761):dbcount(0x7f4ae5dd5f50)
15:45:51.660839 34287 (dblib.c:1443):dbclose(0x7f4ae5dd5f50)
15:45:51.660850 34287 (dblib.c:258):dblib_del_connection(0x7f4ad67d0760, 0x7f4ae5eccf70)
15:45:51.660862 34287 (mem.c:615):tds_free_all_results()
15:45:51.661260 34287 (util.c:156):Changed query state from PENDING to DEAD
15:45:51.661390 34287 (dblib.c:305):dblib_release_tds_ctx(1)
15:45:51.661421 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5dd5f50)
15:45:51.661433 34287 (dblib.c:739):dbloginfree(0x7f4ae5dd7dc0)
15:45:51.661443 34287 (dblib.c:1512):dbexit(void)
15:45:51.661456 34287 (dblib.c:305):dblib_release_tds_ctx(1)
15:45:51.661599 34287 (dblib.c:670):dbinit(void)
15:45:51.661618 34287 (dblib.c:273):dblib_get_tds_ctx(void)
15:45:51.661630 34287 (locale.c:69):Attempting to read locales.conf file
15:45:51.661658 34287 (dblib.c:4945):dberrhandle(0x7f4ad67d2800)
15:45:51.661670 34287 (dblib.c:4964):dbmsghandle(0x7f4ad67d37b0)
15:45:51.661724 34287 (dblib.c:713):dblogin(void)
15:45:51.661739 34287 (dblib.c:761):dbsetlname(0x7f4ae5eee250, sa, 2)
15:45:51.661749 34287 (dblib.c:761):dbsetlname(0x7f4ae5eee250, not1common, 3)
15:45:51.661758 34287 (dblib.c:1146):dbopen(0x7f4ae5eee250, 10.15.2.70:5000, [sybase])
15:45:51.661769 34287 (dblib.c:273):dblib_get_tds_ctx(void)
15:45:51.661785 34287 (config.c:185):Getting connection information for [10.15.2.70:5000].
15:45:51.661791 34287 (config.c:189):Attempting to read conf files.
15:45:51.661797 34287 (config.c:354):... $FREETDSCONF not set. Trying $FREETDS/etc.
15:45:51.661802 34287 (config.c:367):... $FREETDS not set. Trying $HOME.
15:45:51.661862 34287 (config.c:293):Could not open '/var/lib/postgresql/.freetds.conf' ((.freetds.conf)).
15:45:51.661876 34287 (config.c:297):Found conf file '/etc/freetds/freetds.conf' (default).
15:45:51.661882 34287 (config.c:483):Looking for section global.
15:45:51.661911 34287 (config.c:540): Found section global.
15:45:51.661918 34287 (config.c:543):Got a match.
15:45:51.661925 34287 (config.c:565): dump file = '/tmp/freetds.log'
15:45:51.661931 34287 (config.c:565): debug flags = '0xffff'
15:45:51.661937 34287 (config.c:565): timeout = '30'
15:45:51.661943 34287 (config.c:565): connect timeout = '10'
15:45:51.661949 34287 (config.c:565): text size = '64512'
15:45:51.661955 34287 (config.c:540): Found section sybase.
15:45:51.661961 34287 (config.c:540): Found section egserver70.
15:45:51.661968 34287 (config.c:554): Reached EOF
15:45:51.661973 34287 (config.c:483):Looking for section 10.15.2.70:5000.
15:45:51.661980 34287 (config.c:540): Found section global.
15:45:51.661988 34287 (config.c:540): Found section sybase.
15:45:51.661994 34287 (config.c:540): Found section egserver70.
15:45:51.662000 34287 (config.c:554): Reached EOF
15:45:51.662004 34287 (config.c:303):[10.15.2.70:5000] not found.
15:45:51.662040 34287 (config.c:354):... $FREETDSCONF not set. Trying $FREETDS/etc.
15:45:51.662049 34287 (config.c:367):... $FREETDS not set. Trying $HOME.
15:45:51.662097 34287 (config.c:293):Could not open '/var/lib/postgresql/.freetds.conf' ((.freetds.conf)).
15:45:51.662120 34287 (config.c:297):Found conf file '/etc/freetds/freetds.conf' (default).
15:45:51.662132 34287 (config.c:483):Looking for section global.
15:45:51.662155 34287 (config.c:540): Found section global.
15:45:51.662168 34287 (config.c:543):Got a match.
15:45:51.662180 34287 (config.c:565): dump file = '/tmp/freetds.log'
15:45:51.662193 34287 (config.c:565): debug flags = '0xffff'
15:45:51.662206 34287 (config.c:565): timeout = '30'
15:45:51.662218 34287 (config.c:565): connect timeout = '10'
15:45:51.662229 34287 (config.c:565): text size = '64512'
15:45:51.662240 34287 (config.c:540): Found section sybase.
15:45:51.662253 34287 (config.c:540): Found section egserver70.
15:45:51.662267 34287 (config.c:554): Reached EOF
15:45:51.662278 34287 (config.c:483):Looking for section 10.15.2.70.
15:45:51.662292 34287 (config.c:540): Found section global.
15:45:51.662307 34287 (config.c:540): Found section sybase.
15:45:51.662319 34287 (config.c:540): Found section egserver70.
15:45:51.662329 34287 (config.c:554): Reached EOF
15:45:51.662337 34287 (config.c:303):[10.15.2.70] not found.
15:45:51.662364 34287 (iconv.c:330):tds_iconv_open(0x7f4ae5dd7d50, UTF-8)
15:45:51.662393 34287 (iconv.c:349):setting up conversions for client charset "UTF-8"
15:45:51.662398 34287 (iconv.c:351):preparing iconv for "UTF-8" <-> "UCS-2LE" conversion
15:45:51.662418 34287 (iconv.c:391):preparing iconv for "ISO-8859-1" <-> "ISO-8859-1" conversion
15:45:51.662425 34287 (iconv.c:394):tds_iconv_open: done
15:45:51.662432 34287 (net.c:205):Connecting to 10.15.2.70 port 5000 (TDS version 4.2)
15:45:51.662565 34287 (net.c:270):tds_open_socket: connect(2) returned "Operation now in progress"
15:45:51.781873 34287 (net.c:310):tds_open_socket() succeeded
15:45:51.781934 34287 (util.c:156):Changed query state from DEAD to IDLE
15:45:51.781993 34287 (net.c:741):Sending packet
0000 02 00 02 00 00 00 00 00-62 69 74 61 72 65 6e 61 |........ bitarena|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0020 00 00 00 00 00 00 08 73-61 00 00 00 00 00 00 00 |.......s a.......|
0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0040 00 00 00 00 00 02 6e 6f-74 31 63 6f 6d 6d 6f 6e |......no t1common|
0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0060 00 00 00 00 0a 33 34 32-38 37 00 00 00 00 00 00 |.....342 87......|
0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........|
0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00b0 00 00 00 31 30 2e 31 35-2e 32 2e 37 30 3a 35 30 |...10.15 .2.70:50|
00c0 30 30 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |00...... ........|
00d0 00 0f 6e 6f 74 31 63 6f-6d 6d 6f 6e 00 00 00 00 |..not1co mmon....|
00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01d0 00 0a 04 02 00 00 44 42-2d 4c 69 62 72 61 72 79 |......DB -Library|
01e0 0a 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli|
01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........|
15:45:51.782248 34287 (net.c:741):Sending packet
0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 75 74 66 |........ .....utf|
0020 38 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |8....... ........|
0030 00 00 00 00 00 00 00 00-00 00 00 04 01 35 31 32 |........ .....512|
0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....|
15:45:51.782395 34287 (token.c:328):tds_process_login_tokens()
15:45:51.912087 34287 (net.c:555):Received header
0000 04 01 00 70 00 00 00 00- |...p....|
15:45:51.912214 34287 (net.c:609):Received packet
0000 04 01 00 70 00 00 00 00-e3 0f 00 01 06 6d 61 73 |...p.... .....mas|
0010 74 65 72 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |ter.mast er.:.E..|
0020 00 02 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 6d 61 73 74 65 72-27 2e 0a 08 76 61 73 74 | 'master '...vast|
0050 67 5f 64 62 00 00 00 ad-0d 00 01 04 02 00 00 03 |g_db.... ........|
0060 41 53 45 0f 07 00 00 fd-00 00 02 00 5c 00 00 00 |ASE..... .......|
15:45:51.912284 34287 (token.c:337):looking for login token, got e3(ENVCHANGE)
15:45:51.912297 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.912315 34287 (dblib.c:327):db_env_chg(0x7f4ae5dd7d50, 1, master, master)
15:45:51.912329 34287 (token.c:337):looking for login token, got ab(INFO)
15:45:51.912339 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.912351 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.912367 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.912377 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5edcfd0, 0x7f4ae5dd7d50, 0x7ffffe5d9090)
15:45:51.912388 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'master'.
"
15:45:51.912839 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.912869 34287 (token.c:337):looking for login token, got ad(LOGINACK)
15:45:51.912881 34287 (token.c:373):server reports TDS version 4.2.0.0
15:45:51.912892 34287 (token.c:375):Product name for 0x4020000 is unknown
15:45:51.912905 34287 (token.c:337):looking for login token, got fd(DONE)
15:45:51.912916 34287 (token.c:122):tds_process_default_tokens() marker is fd(DONE)
15:45:51.912927 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.912938 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.912948 34287 (token.c:2370): rows_affected = 92
15:45:51.912958 34287 (token.c:438):tds_process_login_tokens() returning TDS_SUCCEED
15:45:51.913001 34287 (mem.c:615):tds_free_all_results()
15:45:51.913015 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.913027 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.913038 34287 (net.c:741):Sending packet
0000 01 01 00 1b 00 00 00 00-73 65 74 20 74 65 78 74 |........ set text|
0010 73 69 7a 65 20 36 34 35-31 32 20 |size 645 12 |
15:45:51.913302 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d91c8, 0x7ffffe5d91cc, 0x100)
15:45:51.913332 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.026788 34287 (net.c:555):Received header
0000 04 01 00 11 00 00 00 00- |........|
15:45:52.026862 34287 (net.c:609):Received packet
0000 04 01 00 11 00 00 00 00-fd 00 00 02 00 00 00 00 |........ ........|
0010 00 - |.|
15:45:52.026881 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:52.026894 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:52.026902 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:52.026910 34287 (util.c:156):Changed query state from READING to IDLE
15:45:52.026919 34287 (token.c:2370): rows_affected = 0
15:45:52.026927 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:52.026935 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d91c8, 0x7ffffe5d91cc, 0x100)
15:45:52.026944 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:52.026956 34287 (dblib.c:239):dblib_add_connection(0x7f4ad67d0760, 0x7f4ae5dd7d50)
15:45:52.027000 34287 (dblib.c:1398):dbuse(0x7f4ae5eccf70, sas_db)
15:45:52.027027 34287 (dblib.c:1312):dbcmd(0x7f4ae5eccf70, use [sas_db])
15:45:52.027041 34287 (dblib.c:1319):dbcmd() bufsz = 0
15:45:52.027052 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5eccf70)
15:45:52.027063 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5eccf70)
15:45:52.027074 34287 (mem.c:615):tds_free_all_results()
15:45:52.027085 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:52.027097 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:52.027107 34287 (net.c:741):Sending packet
0000 01 01 00 14 00 00 00 00-75 73 65 20 5b 73 61 73 |........ use [sas|
0010 5f 64 62 5d - |_db]|
15:45:52.027299 34287 (dblib.c:4639):dbsqlok(0x7f4ae5eccf70)
15:45:52.027327 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:52.027339 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d9628, 0x7ffffe5d962c, 0x6914)
15:45:52.027350 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.144390 34287 (net.c:555):Received header
0000 04 01 00 60 00 00 00 00- |...`....|
15:45:52.144481 34287 (net.c:609):Received packet
0000 04 01 00 60 00 00 00 00-e3 0f 00 01 06 73 61 73 |...`.... .....sas|
0010 5f 64 62 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |_db.mast er.:.E..|
0020 00 01 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 73 61 73 5f 64 62-27 2e 0a 08 76 61 73 74 | 'sas_db '...vast|
0050 67 5f 64 62 00 01 00 fd-00 00 02 00 00 00 00 00 |g_db.... ........|
15:45:52.144543 34287 (token.c:555):processing result tokens. marker is e3(ENVCHANGE)
15:45:52.144556 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:52.144574 34287 (dblib.c:327):db_env_chg(0x7f4ae5dd7d50, 1, master, sas_db)
15:45:52.144590 34287 (token.c:555):processing result tokens. marker is ab(INFO)
15:45:52.144601 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:52.144612 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:52.144626 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:52.144637 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5edcfd0, 0x7f4ae5dd7d50, 0x7ffffe5d9480)
15:45:52.144680 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'sas_db'.
"
15:45:52.145166 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:52.145204 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:52.145228 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:52.145252 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:52.145273 34287 (util.c:156):Changed query state from READING to IDLE
15:45:52.145291 34287 (token.c:2370): rows_affected = 0
15:45:52.145309 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:52.145321 34287 (dblib.c:4707):dbsqlok() end status is SUCCEED
15:45:52.145331 34287 (dblib.c:4718):dbsqlok() end status was success
15:45:52.145341 34287 (dblib.c:1668):dbresults(0x7f4ae5eccf70)
15:45:52.145352 34287 (dblib.c:1674):dbresults: dbresults_state is 5 (_DB_RES_SUCCEED)
15:45:52.145363 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:52.145373 34287 (dblib.c:5854):dbcanquery(0x7f4ae5eccf70)
15:45:52.145383 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d964c, (nil), 0x108)
15:45:52.145398 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:52.145516 34287 (dblib.c:1312):dbcmd(0x7f4ae5eccf70, select * from web_app.ApiSession)
15:45:52.145548 34287 (dblib.c:1319):dbcmd() bufsz = 13
15:45:52.145569 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5eccf70)
15:45:52.145591 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5eccf70)
15:45:52.145611 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5eccf70)
15:45:52.145632 34287 (mem.c:615):tds_free_all_results()
15:45:52.145653 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:52.145677 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:52.145698 34287 (net.c:741):Sending packet
0000 01 01 00 28 00 00 00 00-73 65 6c 65 63 74 20 2a |...(.... select *|
0010 20 66 72 6f 6d 20 77 65-62 5f 61 70 70 2e 41 70 | from we b_app.Ap|
0020 69 53 65 73 73 69 6f 6e- |iSession|
15:45:52.146241 34287 (dblib.c:4639):dbsqlok(0x7f4ae5eccf70)
15:45:52.146325 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:52.146359 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95b8, 0x7ffffe5d95bc, 0x6914)
15:45:52.146401 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.262567 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:52.262671 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-7c 73 0a 69 71 00 00 00 |........ |s.iq...|
0010 00 a0 96 00 0c 41 70 69-53 65 73 73 69 6f 6e 49 |.....Api SessionI|
0020 64 14 41 70 69 53 65 73-73 69 6f 6e 43 72 65 61 |d.ApiSes sionCrea|
0030 74 6f 72 55 49 44 14 41-64 6d 69 6e 69 73 74 72 |torUID.A dministr|
0040 61 74 6f 72 4c 6f 67 69-6e 49 64 10 4d 65 65 74 |atorLogi nId.Meet|
0050 69 6e 67 53 65 73 73 69-6f 6e 49 64 13 41 70 69 |ingSessi onId.Api|
0060 53 65 73 73 69 6f 6e 55-73 65 72 4e 6f 74 65 73 |SessionU serNotes|
0070 12 41 70 69 53 65 73 73-69 6f 6e 4d 6f 64 4e 6f |.ApiSess ionModNo|
0080 74 65 73 13 41 70 69 53-65 73 73 69 6f 6e 49 73 |tes.ApiS essionIs|
0090 44 65 6c 65 74 65 64 12-41 70 69 53 65 73 73 69 |Deleted. ApiSessi|
00a0 6f 6e 52 65 6d 6f 74 65-49 64 a1 60 00 2b 00 00 |onRemote Id.`.+..|
00b0 00 6d 08 23 00 00 00 e1-40 00 00 00 2b 00 00 00 |.m.#.... @...+...|
00c0 6d 08 2b 00 00 00 6d 08-14 00 00 00 22 00 fc 00 |m.+...m. ...."...|
00d0 00 12 00 77 65 62 5f 61-70 70 2e 41 70 69 53 65 |...web_a pp.ApiSe|
00e0 73 73 69 6f 6e 14 00 00-00 22 00 fc 00 00 12 00 |ssion... ."......|
00f0 77 65 62 5f 61 70 70 2e-41 70 69 53 65 73 73 69 |web_app. ApiSessi|
0100 6f 6e 10 00 00 00 32 2b-00 00 00 6d 08 ae 08 00 |on....2+ ...m....|
0110 00 00 00 00 00 00 00 00-d1 08 00 00 00 00 00 00 |........ ........|
0120 f0 3f 2a 00 00 00 62 00-72 00 75 00 63 00 65 00 |.?...b. r.u.c.e.|
0130 73 00 40 00 65 00 6c 00-6c 00 75 00 6d 00 69 00 |[email protected]. l.u.m.i.|
0140 6e 00 61 00 74 00 65 00-2e 00 63 00 6f 00 6d 00 |n.a.t.e. ..c.o.m.|
0150 08 00 00 00 00 28 cd 02-41 08 00 00 00 00 20 de |.....(.. A..... .|
0160 fd 40 10 5a 04 00 00 00-00 00 00 00 00 00 00 eb |[email protected].... ........|
0170 b0 4c 00 00 00 00 00 00-4c b0 eb 02 00 00 00 20 |.L...... L...... |
0180 00 10 5b 04 00 00 00 00-00 00 00 00 00 00 f2 b0 |..[..... ........|
0190 4c 00 00 00 00 00 00 4c-b0 f2 02 00 00 00 20 00 |L......L ...... .|
01a0 01 08 00 00 00 00 00 00-f0 3f d1 08 00 00 00 00 |........ .?......|
01b0 00 00 00 40 2a 00 00 00-62 00 72 00 75 00 63 00 |...@... b.r.u.c.|
01c0 65 00 73 00 40 00 65 00-6c 00 6c 00 75 00 6d 00 |[email protected]. l.l.u.m.|
01d0 69 00 6e 00 61 00 74 00-65 00 2e 00 63 00 6f 00 |i.n.a.t. e...c.o.|
01e0 6d 00 08 00 00 00 00 28-cd 02 41 08 00 00 00 00 |m......( ..A.....|
01f0 30 de fd 40 10 5c 04 00-00 00 00 00 00 00 00 00 |0..@... ........|
15:45:52.262963 34287 (token.c:555):processing result tokens. marker is 7c(PROCID)
15:45:52.262978 34287 (token.c:122):tds_process_default_tokens() marker is 7c(PROCID)
15:45:52.262990 34287 (token.c:555):processing result tokens. marker is a0(COLNAME)
15:45:52.263012 34287 (mem.c:615):tds_free_all_results()
15:45:52.263053 34287 (token.c:555):processing result tokens. marker is a1(COLFMT)
15:45:52.263069 34287 (token.c:1025):processing result. type = 109(float-null), varint_size 1
15:45:52.263082 34287 (token.c:1025):processing result. type = 35(text), varint_size 1
15:45:52.263148 34287 (token.c:3420):adjust_character_column_size:
Server charset: UTF-16LE
Server column_size: 64
Client charset: UTF-8
Client column_size: 128
15:45:52.263164 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263176 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263187 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263198 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263208 34287 (token.c:1025):processing result. type = 98(variant), varint_size 1
15:45:52.263219 34287 (token.c:1025):processing result. type = 65(), varint_size 1
15:45:52.263230 34287 (token.c:1053):NOTE:tds_process_col_fmt: draining 48 bytes
15:45:52.263242 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.263255 34287 (dblib.c:4700):dbsqlok() found result token
15:45:52.263267 34287 (dblib.c:1668):dbresults(0x7f4ae5eccf70)
15:45:52.263278 34287 (dblib.c:1674):dbresults: dbresults_state is 1 (_DB_RES_RESULTSET_EMPTY)
15:45:52.263288 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95a8, 0x7ffffe5d95ac, 0x6914)
15:45:52.263299 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.263309 34287 (token.c:555):processing result tokens. marker is ae(CONTROL)
15:45:52.263319 34287 (token.c:122):tds_process_default_tokens() marker is ae(CONTROL)
15:45:52.263330 34287 (token.c:237):Eating CONTROL token
15:45:52.263340 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:52.263351 34287 (token.c:666):tds_process_tokens::SET_RETURN stopping on current token
15:45:52.263361 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.263371 34287 (dblib.c:1695):dbresults() tds_process_tokens returned 1 (TDS_SUCCEED),
result_type TDS_ROW_RESULT
15:45:52.263382 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:52.263392 34287 (dblib.c:2018):dbnextrow(0x7f4ae5eccf70)
15:45:52.263402 34287 (dblib.c:2031):dbnextrow() dbresults_state = 2 (_DB_RES_RESULTSET_ROWS)
15:45:52.263412 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95bc, (nil), 0x1508)
15:45:52.263426 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.263435 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:52.263446 34287 (token.c:2304):tds_process_row(): reading column 0
15:45:52.263456 34287 (token.c:2049):tds_get_data: type 109, varint size 1
15:45:52.263466 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:52.263476 34287 (token.c:2304):tds_process_row(): reading column 1
15:45:52.263486 34287 (token.c:2049):tds_get_data: type 35, varint size 1
15:45:52.263510 34287 (token.c:2110):tds_get_data(): wire column size is 42
15:45:52.263528 34287 (token.c:2304):tds_process_row(): reading column 2
15:45:52.263539 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263549 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:52.263559 34287 (token.c:2304):tds_process_row(): reading column 3
15:45:52.263568 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263577 34287 (token.c:2110):tds_get_data(): wire column size is 109
15:45:52.263587 34287 (token.c:2304):tds_process_row(): reading column 4
15:45:52.263597 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263606 34287 (token.c:2110):tds_get_data(): wire column size is 117
15:45:52.265020 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:52.265047 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-00 fb b0 4c 00 00 00 00 |........ ...L....|
0010 00 00 4c b0 fb 02 00 00-00 20 00 10 5d 04 00 00 |..L..... . ..]...|
0020 00 00 00 00 00 00 00 00-02 b1 4c 00 00 00 00 00 |........ ..L.....|
0030 00 4c b1 02 02 00 00 00-20 00 00 08 00 00 00 00 |.L...... .......|
0040 00 00 00 40 d1 08 00 00-00 00 00 00 08 40 2a 00 |...@.... .....@.|
0050 00 00 62 00 72 00 75 00-63 00 65 00 73 00 40 00 |..b.r.u. c.e.s.@.|
0060 65 00 6c 00 6c 00 75 00-6d 00 69 00 6e 00 61 00 |e.l.l.u. m.i.n.a.|
0070 74 00 65 00 2e 00 63 00-6f 00 6d 00 08 00 00 00 |t.e...c. o.m.....|
0080 00 28 cd 02 41 08 00 00-00 00 40 de fd 40 10 5e |.(..A... ..@..@.^|
0090 04 00 00 00 00 00 00 00-00 00 00 0b b1 4c 00 00 |........ .....L..|
00a0 00 00 00 00 4c b1 0b 02-00 00 00 20 00 10 5f 04 |....L... ... ...|
00b0 00 00 00 00 00 00 00 00-00 00 12 b1 4c 00 00 00 |........ ....L...|
00c0 00 00 00 4c b1 12 02 00-00 00 20 00 00 08 00 00 |...L.... .. .....|
00d0 00 00 00 00 08 40 d1 08-00 00 00 00 00 00 10 40 |.....@.. .......@|
00e0 2a 00 00 00 62 00 72 00-75 00 63 00 65 00 73 00 |_...b.r. u.c.e.s.|
00f0 40 00 65 00 6c 00 6c 00-75 00 6d 00 69 00 6e 00 |@.e.l.l. u.m.i.n.|
0100 61 00 74 00 65 00 2e 00-63 00 6f 00 6d 00 08 00 |a.t.e... c.o.m...|
0110 00 00 00 28 cd 02 41 08-00 00 00 00 40 ab fe 40 |...(..A. ....@..@|
0120 10 80 01 23 00 00 00 00-00 00 00 00 00 1b b1 4c |...#.... .......L|
0130 00 00 00 00 00 00 4c b1-1b 02 00 00 00 20 00 10 |......L. ..... ..|
0140 81 01 23 00 00 00 00 00-00 00 00 00 23 b1 4c 00 |..#..... ....#.L.|
0150 00 00 00 00 00 4c b1 23-02 00 00 00 20 00 00 08 |.....L.# .... ...|
0160 00 00 00 00 00 00 10 40-d1 08 00 00 00 00 00 00 |.......@ ........|
0170 24 40 12 00 00 00 75 00-69 00 67 00 63 00 61 00 |[email protected]. i.g.c.a.|
0180 64 00 6d 00 69 00 6e 00-08 00 00 00 00 68 14 03 |d.m.i.n. .....h..|
0190 41 08 00 00 00 00 18 24-00 41 10 82 01 23 00 00 |A......$ .A...#..|
01a0 00 00 00 00 00 00 00 2b-b1 4c 00 00 00 00 00 00 |.......+ .L......|
01b0 4c b1 2b 02 00 00 00 20-00 10 83 01 23 00 00 00 |L.+.... ....#...|
01c0 00 00 00 00 00 00 32 b1-4c 00 00 00 00 00 00 4c |......2. L......L|
01d0 b1 32 02 00 00 00 20 00-00 08 00 00 00 00 00 00 |.2.... . ........|
01e0 24 40 d1 08 00 00 00 00-00 00 26 40 12 00 00 00 |$@...... ..&@....|
01f0 75 00 69 00 67 00 63 00-61 00 64 00 6d 00 69 00 |u.i.g.c. a.d.m.i.|
15:45:52.265173 34287 (token.c:2304):tds_process_row(): reading column 5
15:45:52.265180 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.265190 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:52.265200 34287 (token.c:2304):tds_process_row(): reading column 6
15:45:52.265210 34287 (token.c:2049):tds_get_data: type 98, varint size 1
15:45:52.265220 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:52.265231 34287 (token.c:2304):tds_process_row(): reading column 7
15:45:52.265241 34287 (token.c:2049):tds_get_data: type 65, varint size 1
15:45:52.265250 34287 (token.c:2110):tds_get_data(): wire column size is 209
15:45:52.265258 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.265268 34287 (buffering.h:306):buffer_transfer_bound_data(0x7f4ae5eccf80 4040 -1 0x7f4ae5eccf70 0)
15:45:52.265286 34287 (dblib.c:2100):leaving dbnextrow() returning REG_ROW/MORE_ROWS
15:45:52.265292 34287 (dblib.c:1813):dbnumcols(0x7f4ae5eccf70)
15:45:52.265305 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 1)
15:45:52.265317 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 1)
15:45:52.265322 34287 (dblib.c:3142):dbdatlen() type = 109, len= 8
15:45:52.265328 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 1)
15:45:52.265333 34287 (dblib.c:2812):dbwillconvert(SYBFLT8, SYBCHAR)
15:45:52.265340 34287 (convert.c:2788):tds_willconvert(62, 47)
15:45:52.265348 34287 (convert.c:2792):tds_willconvert(62, 47) returns yes
15:45:52.265356 34287 (dblib.c:2217):dbconvert(0x7f4ae5eccf70, SYBFLT8, 0x7f4ae5ef1020, 8, SYBCHAR, 0x7f4ae5f076a0, -1)
15:45:52.265361 34287 (dblib.c:2349):dbconvert() calling tds_convert
15:45:52.265383 34287 (dblib.c:2352):dbconvert() called tds_convert returned 1
15:45:52.265389 34287 (dblib.c:2455):dbconvert() outputting 1 bytes character data destlen = -1
15:45:52.265395 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 2)
15:45:52.265400 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 2)
15:45:52.265405 34287 (dblib.c:3142):dbdatlen() type = 35, len= 61
15:45:52.265409 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 2)
15:45:52.265414 34287 (dblib.c:2812):dbwillconvert(SYBTEXT, SYBCHAR)
15:45:52.265419 34287 (convert.c:2788):tds_willconvert(35, 47)
15:45:52.265424 34287 (convert.c:2792):tds_willconvert(35, 47) returns yes
15:45:52.265429 34287 (dblib.c:2217):dbconvert(0x7f4ae5eccf70, SYBTEXT, 0x7f4ae5ef1028, 61, SYBCHAR, 0x7f4ae5f07ab0, -1)
15:45:52.265434 34287 (dblib.c:2349):dbconvert() calling tds_convert
15:45:52.265442 34287 (dblib.c:2352):dbconvert() called tds_convert returned 61
15:45:52.265447 34287 (dblib.c:2455):dbconvert() outputting 61 bytes character data destlen = -1
15:45:52.265452 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 3)
15:45:52.265457 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 3)
15:45:52.265462 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265467 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 3)
15:45:52.265471 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 4)
15:45:52.265476 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 4)
15:45:52.265481 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265485 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 4)
15:45:52.265490 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 5)
15:45:52.265494 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 5)
15:45:52.265499 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265504 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 5)
15:45:52.265509 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 6)
15:45:52.265513 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 6)
15:45:52.265518 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265522 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 6)
15:45:52.265527 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 7)
15:45:52.265532 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 7)
15:45:52.265536 34287 (dblib.c:3142):dbdatlen() type = 98, len= 8
15:45:52.265541 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 7)
15:45:52.265545 34287 (dblib.c:2812):dbwillconvert(SYBVARIANT, SYBCHAR)
15:45:52.265550 34287 (convert.c:2788):tds_willconvert(98, 47)
15:45:52.265555 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 8)
15:45:52.265560 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 8)
15:45:52.265565 34287 (dblib.c:3142):dbdatlen() type = 65, len= 112
15:45:52.265569 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 8)
15:45:52.265574 34287 (dblib.c:2812):dbwillconvert(SYBUINT2, SYBCHAR)
15:45:52.265579 34287 (convert.c:2788):tds_willconvert(65, 47)
postgres@bitarena:$
postgres@bitarena:$ clear
postgres@bitarena:~$ cat /tmp/freetds.log | more
15:45:51.071682 34287 (log.c:196):Starting log file for FreeTDS 0.91
on 2014-05-28 15:45:51 with debug flags 0xffff.
15:45:51.071736 34287 (iconv.c:330):tds_iconv_open(0x7f4ae5eccf70, UTF-8)
15:45:51.071925 34287 (iconv.c:187):local name for ISO-8859-1 is ISO-8859-1
15:45:51.071943 34287 (iconv.c:187):local name for UTF-8 is UTF-8
15:45:51.071951 34287 (iconv.c:187):local name for UCS-2LE is UCS-2LE
15:45:51.071959 34287 (iconv.c:187):local name for UCS-2BE is UCS-2BE
15:45:51.071967 34287 (iconv.c:349):setting up conversions for client charset "UTF-8"
15:45:51.071974 34287 (iconv.c:351):preparing iconv for "UTF-8" <-> "UCS-2LE" conversion
15:45:51.071992 34287 (iconv.c:391):preparing iconv for "ISO-8859-1" <-> "ISO-8859-1" conversion
15:45:51.072001 34287 (iconv.c:394):tds_iconv_open: done
15:45:51.072018 34287 (net.c:205):Connecting to 10.15.2.70 port 5000 (TDS version 4.2)
15:45:51.072229 34287 (net.c:270):tds_open_socket: connect(2) returned "Operation now in progress"
15:45:51.187342 34287 (net.c:310):tds_open_socket() succeeded
15:45:51.187427 34287 (util.c:156):Changed query state from DEAD to IDLE
15:45:51.187457 34287 (net.c:741):Sending packet
0000 02 00 02 00 00 00 00 00-62 69 74 61 72 65 6e 61 |........ bitarena|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0020 00 00 00 00 00 00 08 73-61 00 00 00 00 00 00 00 |.......s a.......|
0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0040 00 00 00 00 00 02 6e 6f-74 31 63 6f 6d 6d 6f 6e |......no t1common|
0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0060 00 00 00 00 0a 33 34 32-38 37 00 00 00 00 00 00 |.....342 87......|
0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........|
0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00b0 00 00 00 31 30 2e 31 35-2e 32 2e 37 30 3a 35 30 |...10.15 .2.70:50|
00c0 30 30 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |00...... ........|
00d0 00 0f 6e 6f 74 31 63 6f-6d 6d 6f 6e 00 00 00 00 |..not1co mmon....|
00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01d0 00 0a 04 02 00 00 44 42-2d 4c 69 62 72 61 72 79 |......DB -Library|
01e0 0a 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli|
01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........|
15:45:51.187751 34287 (net.c:741):Sending packet
0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 75 74 66 |........ .....utf|
0020 38 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |8....... ........|
0030 00 00 00 00 00 00 00 00-00 00 00 04 01 35 31 32 |........ .....512|
0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....|
15:45:51.187930 34287 (token.c:328):tds_process_login_tokens()
15:45:51.314519 34287 (net.c:555):Received header
0000 04 01 00 70 00 00 00 00- |...p....|
15:45:51.314647 34287 (net.c:609):Received packet
0000 04 01 00 70 00 00 00 00-e3 0f 00 01 06 6d 61 73 |...p.... .....mas|
0010 74 65 72 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |ter.mast er.:.E..|
0020 00 02 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 6d 61 73 74 65 72-27 2e 0a 08 76 61 73 74 | 'master '...vast|
0050 67 5f 64 62 00 00 00 ad-0d 00 01 04 02 00 00 03 |g_db.... ........|
0060 41 53 45 0f 07 00 00 fd-00 00 02 00 33 00 00 00 |ASE..... ....3...|
15:45:51.314718 34287 (token.c:337):looking for login token, got e3(ENVCHANGE)
15:45:51.314742 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.314774 34287 (dblib.c:327):db_env_chg(0x7f4ae5eccf70, 1, master, master)
15:45:51.314792 34287 (token.c:337):looking for login token, got ab(INFO)
15:45:51.314803 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.314814 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.314831 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.314843 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5dd7d70, 0x7f4ae5eccf70, 0x7ffffe5d8df0)
15:45:51.314854 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'master'.
"
15:45:51.315037 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.315059 34287 (token.c:337):looking for login token, got ad(LOGINACK)
15:45:51.315071 34287 (token.c:373):server reports TDS version 4.2.0.0
15:45:51.315083 34287 (token.c:375):Product name for 0x4020000 is unknown
15:45:51.315096 34287 (token.c:337):looking for login token, got fd(DONE)
15:45:51.315106 34287 (token.c:122):tds_process_default_tokens() marker is fd(DONE)
15:45:51.315122 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.315135 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.315145 34287 (token.c:2370): rows_affected = 51
15:45:51.315156 34287 (token.c:438):tds_process_login_tokens() returning TDS_SUCCEED
15:45:51.315178 34287 (mem.c:615):tds_free_all_results()
15:45:51.315190 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.315205 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.315216 34287 (net.c:741):Sending packet
0000 01 01 00 1b 00 00 00 00-73 65 74 20 74 65 78 74 |........ set text|
0010 73 69 7a 65 20 36 34 35-31 32 20 |size 645 12 |
15:45:51.315386 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d8f28, 0x7ffffe5d8f2c, 0x100)
15:45:51.315413 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.426652 34287 (net.c:555):Received header
0000 04 01 00 11 00 00 00 00- |........|
15:45:51.426750 34287 (net.c:609):Received packet
0000 04 01 00 11 00 00 00 00-fd 00 00 02 00 00 00 00 |........ ........|
0010 00 - |.|
15:45:51.426776 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:51.426792 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.426804 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.426815 34287 (util.c:156):Changed query state from READING to IDLE
15:45:51.426826 34287 (token.c:2370): rows_affected = 0
15:45:51.426837 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:51.426847 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d8f28, 0x7ffffe5d8f2c, 0x100)
15:45:51.426859 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:51.426875 34287 (dblib.c:239):dblib_add_connection(0x7f4ad67d0760, 0x7f4ae5eccf70)
15:45:51.426892 34287 (dblib.c:1398):dbuse(0x7f4ae5dd5f50, sas_db)
15:45:51.426907 34287 (dblib.c:1312):dbcmd(0x7f4ae5dd5f50, use [sas_db])
15:45:51.426927 34287 (dblib.c:1319):dbcmd() bufsz = 0
15:45:51.426936 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5dd5f50)
15:45:51.426977 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5dd5f50)
15:45:51.426988 34287 (mem.c:615):tds_free_all_results()
15:45:51.426996 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.427005 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.427013 34287 (net.c:741):Sending packet
0000 01 01 00 14 00 00 00 00-75 73 65 20 5b 73 61 73 |........ use [sas|
0010 5f 64 62 5d - |_db]|
15:45:51.427191 34287 (dblib.c:4639):dbsqlok(0x7f4ae5dd5f50)
15:45:51.427211 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:51.427219 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d9388, 0x7ffffe5d938c, 0x6914)
15:45:51.427228 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.541554 34287 (net.c:555):Received header
0000 04 01 00 60 00 00 00 00- |...`....|
15:45:51.541627 34287 (net.c:609):Received packet
0000 04 01 00 60 00 00 00 00-e3 0f 00 01 06 73 61 73 |...`.... .....sas|
0010 5f 64 62 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |_db.mast er.:.E..|
0020 00 01 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 73 61 73 5f 64 62-27 2e 0a 08 76 61 73 74 | 'sas_db '...vast|
0050 67 5f 64 62 00 01 00 fd-00 00 02 00 00 00 00 00 |g_db.... ........|
15:45:51.541673 34287 (token.c:555):processing result tokens. marker is e3(ENVCHANGE)
15:45:51.541683 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.541695 34287 (dblib.c:327):db_env_chg(0x7f4ae5eccf70, 1, master, sas_db)
15:45:51.541706 34287 (token.c:555):processing result tokens. marker is ab(INFO)
15:45:51.541714 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.541722 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.541733 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.541741 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5dd7d70, 0x7f4ae5eccf70, 0x7ffffe5d91e0)
15:45:51.541750 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'sas_db'.
"
15:45:51.542038 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.542067 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:51.542078 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.542087 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.542094 34287 (util.c:156):Changed query state from READING to IDLE
15:45:51.542102 34287 (token.c:2370): rows_affected = 0
15:45:51.542109 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:51.542125 34287 (dblib.c:4707):dbsqlok() end status is SUCCEED
15:45:51.542134 34287 (dblib.c:4718):dbsqlok() end status was success
15:45:51.542144 34287 (dblib.c:1668):dbresults(0x7f4ae5dd5f50)
15:45:51.542153 34287 (dblib.c:1674):dbresults: dbresults_state is 5 (_DB_RES_SUCCEED)
15:45:51.542161 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:51.542169 34287 (dblib.c:5854):dbcanquery(0x7f4ae5dd5f50)
15:45:51.542176 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93ac, (nil), 0x108)
15:45:51.542222 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:51.542232 34287 (dblib.c:1312):dbcmd(0x7f4ae5dd5f50, select * from web_app.ApiSession)
15:45:51.542240 34287 (dblib.c:1319):dbcmd() bufsz = 13
15:45:51.542247 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5dd5f50)
15:45:51.542255 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5dd5f50)
15:45:51.542263 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5dd5f50)
15:45:51.542272 34287 (mem.c:615):tds_free_all_results()
15:45:51.542280 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.542289 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.542297 34287 (net.c:741):Sending packet
0000 01 01 00 28 00 00 00 00-73 65 6c 65 63 74 20 2a |...(.... select *|
0010 20 66 72 6f 6d 20 77 65-62 5f 61 70 70 2e 41 70 | from we b_app.Ap|
0020 69 53 65 73 73 69 6f 6e- |iSession|
15:45:51.542470 34287 (dblib.c:4639):dbsqlok(0x7f4ae5dd5f50)
15:45:51.542490 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:51.542498 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93e8, 0x7ffffe5d93ec, 0x6914)
15:45:51.542507 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.656744 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:51.656815 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-7c 73 0a 69 71 00 00 00 |........ |s.iq...|
0010 00 a0 96 00 0c 41 70 69-53 65 73 73 69 6f 6e 49 |.....Api SessionI|
0020 64 14 41 70 69 53 65 73-73 69 6f 6e 43 72 65 61 |d.ApiSes sionCrea|
0030 74 6f 72 55 49 44 14 41-64 6d 69 6e 69 73 74 72 |torUID.A dministr|
0040 61 74 6f 72 4c 6f 67 69-6e 49 64 10 4d 65 65 74 |atorLogi nId.Meet|
0050 69 6e 67 53 65 73 73 69-6f 6e 49 64 13 41 70 69 |ingSessi onId.Api|
0060 53 65 73 73 69 6f 6e 55-73 65 72 4e 6f 74 65 73 |SessionU serNotes|
0070 12 41 70 69 53 65 73 73-69 6f 6e 4d 6f 64 4e 6f |.ApiSess ionModNo|
0080 74 65 73 13 41 70 69 53-65 73 73 69 6f 6e 49 73 |tes.ApiS essionIs|
0090 44 65 6c 65 74 65 64 12-41 70 69 53 65 73 73 69 |Deleted. ApiSessi|
00a0 6f 6e 52 65 6d 6f 74 65-49 64 a1 60 00 2b 00 00 |onRemote Id.`.+..|
00b0 00 6d 08 23 00 00 00 e1-40 00 00 00 2b 00 00 00 |.m.#.... @...+...|
00c0 6d 08 2b 00 00 00 6d 08-14 00 00 00 22 00 fc 00 |m.+...m. ...."...|
00d0 00 12 00 77 65 62 5f 61-70 70 2e 41 70 69 53 65 |...web_a pp.ApiSe|
00e0 73 73 69 6f 6e 14 00 00-00 22 00 fc 00 00 12 00 |ssion... ."......|
00f0 77 65 62 5f 61 70 70 2e-41 70 69 53 65 73 73 69 |web_app. ApiSessi|
0100 6f 6e 10 00 00 00 32 2b-00 00 00 6d 08 ae 08 00 |on....2+ ...m....|
0110 00 00 00 00 00 00 00 00-d1 08 00 00 00 00 00 00 |........ ........|
0120 f0 3f 2a 00 00 00 62 00-72 00 75 00 63 00 65 00 |.?...b. r.u.c.e.|
0130 73 00 40 00 65 00 6c 00-6c 00 75 00 6d 00 69 00 |[email protected]. l.u.m.i.|
0140 6e 00 61 00 74 00 65 00-2e 00 63 00 6f 00 6d 00 |n.a.t.e. ..c.o.m.|
0150 08 00 00 00 00 28 cd 02-41 08 00 00 00 00 20 de |.....(.. A..... .|
0160 fd 40 10 5a 04 00 00 00-00 00 00 00 00 00 00 eb |[email protected].... ........|
0170 b0 4c 00 00 00 00 00 00-4c b0 eb 02 00 00 00 20 |.L...... L...... |
0180 00 10 5b 04 00 00 00 00-00 00 00 00 00 00 f2 b0 |..[..... ........|
0190 4c 00 00 00 00 00 00 4c-b0 f2 02 00 00 00 20 00 |L......L ...... .|
01a0 01 08 00 00 00 00 00 00-f0 3f d1 08 00 00 00 00 |........ .?......|
01b0 00 00 00 40 2a 00 00 00-62 00 72 00 75 00 63 00 |...@... b.r.u.c.|
01c0 65 00 73 00 40 00 65 00-6c 00 6c 00 75 00 6d 00 |[email protected]. l.l.u.m.|
01d0 69 00 6e 00 61 00 74 00-65 00 2e 00 63 00 6f 00 |i.n.a.t. e...c.o.|
01e0 6d 00 08 00 00 00 00 28-cd 02 41 08 00 00 00 00 |m......( ..A.....|
01f0 30 de fd 40 10 5c 04 00-00 00 00 00 00 00 00 00 |0..@... ........|
15:45:51.656965 34287 (token.c:555):processing result tokens. marker is 7c(PROCID)
15:45:51.656973 34287 (token.c:122):tds_process_default_tokens() marker is 7c(PROCID)
15:45:51.656980 34287 (token.c:555):processing result tokens. marker is a0(COLNAME)
15:45:51.656993 34287 (mem.c:615):tds_free_all_results()
15:45:51.657024 34287 (token.c:555):processing result tokens. marker is a1(COLFMT)
15:45:51.657034 34287 (token.c:1025):processing result. type = 109(float-null), varint_size 1
15:45:51.657042 34287 (token.c:1025):processing result. type = 35(text), varint_size 1
15:45:51.657258 34287 (token.c:3420):adjust_character_column_size:
Server charset: UTF-16LE
Server column_size: 64
Client charset: UTF-8
Client column_size: 128
15:45:51.657274 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657282 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657289 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657296 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657302 34287 (token.c:1025):processing result. type = 98(variant), varint_size 1
15:45:51.657325 34287 (token.c:1025):processing result. type = 65(), varint_size 1
15:45:51.657333 34287 (token.c:1053):NOTE:tds_process_col_fmt: draining 48 bytes
15:45:51.657341 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.657350 34287 (dblib.c:4700):dbsqlok() found result token
15:45:51.657357 34287 (dblib.c:1668):dbresults(0x7f4ae5dd5f50)
15:45:51.657364 34287 (dblib.c:1674):dbresults: dbresults_state is 1 (_DB_RES_RESULTSET_EMPTY)
15:45:51.657371 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93d8, 0x7ffffe5d93dc, 0x6914)
15:45:51.657378 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.657384 34287 (token.c:555):processing result tokens. marker is ae(CONTROL)
15:45:51.657391 34287 (token.c:122):tds_process_default_tokens() marker is ae(CONTROL)
15:45:51.657397 34287 (token.c:237):Eating CONTROL token
15:45:51.657404 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:51.657411 34287 (token.c:666):tds_process_tokens::SET_RETURN stopping on current token
15:45:51.657417 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.657423 34287 (dblib.c:1695):dbresults() tds_process_tokens returned 1 (TDS_SUCCEED),
result_type TDS_ROW_RESULT
15:45:51.657430 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:51.657441 34287 (dblib.c:2018):dbnextrow(0x7f4ae5dd5f50)
15:45:51.657448 34287 (dblib.c:2031):dbnextrow() dbresults_state = 2 (_DB_RES_RESULTSET_ROWS)
15:45:51.657455 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93ec, (nil), 0x1508)
15:45:51.657464 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.657470 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:51.657477 34287 (token.c:2304):tds_process_row(): reading column 0
15:45:51.657483 34287 (token.c:2049):tds_get_data: type 109, varint size 1
15:45:51.657490 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:51.657496 34287 (token.c:2304):tds_process_row(): reading column 1
15:45:51.657502 34287 (token.c:2049):tds_get_data: type 35, varint size 1
15:45:51.657508 34287 (token.c:2110):tds_get_data(): wire column size is 42
15:45:51.657522 34287 (token.c:2304):tds_process_row(): reading column 2
15:45:51.657529 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657535 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:51.657541 34287 (token.c:2304):tds_process_row(): reading column 3
15:45:51.657547 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657553 34287 (token.c:2110):tds_get_data(): wire column size is 109
15:45:51.657560 34287 (token.c:2304):tds_process_row(): reading column 4
15:45:51.657566 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657572 34287 (token.c:2110):tds_get_data(): wire column size is 117
15:45:51.660163 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:51.660215 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-00 fb b0 4c 00 00 00 00 |........ ...L....|
0010 00 00 4c b0 fb 02 00 00-00 20 00 10 5d 04 00 00 |..L..... . ..]...|
0020 00 00 00 00 00 00 00 00-02 b1 4c 00 00 00 00 00 |........ ..L.....|
0030 00 4c b1 02 02 00 00 00-20 00 00 08 00 00 00 00 |.L...... .......|
0040 00 00 00 40 d1 08 00 00-00 00 00 00 08 40 2a 00 |...@.... .....@.|
0050 00 00 62 00 72 00 75 00-63 00 65 00 73 00 40 00 |..b.r.u. c.e.s.@.|
0060 65 00 6c 00 6c 00 75 00-6d 00 69 00 6e 00 61 00 |e.l.l.u. m.i.n.a.|
0070 74 00 65 00 2e 00 63 00-6f 00 6d 00 08 00 00 00 |t.e...c. o.m.....|
0080 00 28 cd 02 41 08 00 00-00 00 40 de fd 40 10 5e |.(..A... ..@..@.^|
0090 04 00 00 00 00 00 00 00-00 00 00 0b b1 4c 00 00 |........ .....L..|
00a0 00 00 00 00 4c b1 0b 02-00 00 00 20 00 10 5f 04 |....L... ... ...|
00b0 00 00 00 00 00 00 00 00-00 00 12 b1 4c 00 00 00 |........ ....L...|
00c0 00 00 00 4c b1 12 02 00-00 00 20 00 00 08 00 00 |...L.... .. .....|
00d0 00 00 00 00 08 40 d1 08-00 00 00 00 00 00 10 40 |.....@.. .......@|
00e0 2a 00 00 00 62 00 72 00-75 00 63 00 65 00 73 00 |_...b.r. u.c.e.s.|
00f0 40 00 65 00 6c 00 6c 00-75 00 6d 00 69 00 6e 00 |@.e.l.l. u.m.i.n.|
0100 61 00 74 00 65 00 2e 00-63 00 6f 00 6d 00 08 00 |a.t.e... c.o.m...|
0110 00 00 00 28 cd 02 41 08-00 00 00 00 40 ab fe 40 |...(..A. ....@..@|
0120 10 80 01 23 00 00 00 00-00 00 00 00 00 1b b1 4c |...#.... .......L|
0130 00 00 00 00 00 00 4c b1-1b 02 00 00 00 20 00 10 |......L. ..... ..|
0140 81 01 23 00 00 00 00 00-00 00 00 00 23 b1 4c 00 |..#..... ....#.L.|
0150 00 00 00 00 00 4c b1 23-02 00 00 00 20 00 00 08 |.....L.# .... ...|
0160 00 00 00 00 00 00 10 40-d1 08 00 00 00 00 00 00 |.......@ ........|
0170 24 40 12 00 00 00 75 00-69 00 67 00 63 00 61 00 |[email protected]. i.g.c.a.|
0180 64 00 6d 00 69 00 6e 00-08 00 00 00 00 68 14 03 |d.m.i.n. .....h..|
0190 41 08 00 00 00 00 18 24-00 41 10 82 01 23 00 00 |A......$ .A...#..|
01a0 00 00 00 00 00 00 00 2b-b1 4c 00 00 00 00 00 00 |.......+ .L......|
01b0 4c b1 2b 02 00 00 00 20-00 10 83 01 23 00 00 00 |L.+.... ....#...|
01c0 00 00 00 00 00 00 32 b1-4c 00 00 00 00 00 00 4c |......2. L......L|
01d0 b1 32 02 00 00 00 20 00-00 08 00 00 00 00 00 00 |.2.... . ........|
01e0 24 40 d1 08 00 00 00 00-00 00 26 40 12 00 00 00 |$@...... ..&@....|
01f0 75 00 69 00 67 00 63 00-61 00 64 00 6d 00 69 00 |u.i.g.c. a.d.m.i.|
15:45:51.660685 34287 (token.c:2304):tds_process_row(): reading column 5
15:45:51.660701 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.660711 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:51.660721 34287 (token.c:2304):tds_process_row(): reading column 6
15:45:51.660731 34287 (token.c:2049):tds_get_data: type 98, varint size 1
15:45:51.660741 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:51.660752 34287 (token.c:2304):tds_process_row(): reading column 7
15:45:51.660763 34287 (token.c:2049):tds_get_data: type 65, varint size 1
15:45:51.660772 34287 (token.c:2110):tds_get_data(): wire column size is 209
15:45:51.660782 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.660799 34287 (buffering.h:306):buffer_transfer_bound_data(0x7f4ae5dd5f60 4040 -1 0x7f4ae5dd5f50 0)
15:45:51.660814 34287 (dblib.c:2100):leaving dbnextrow() returning REG_ROW/MORE_ROWS
15:45:51.660828 34287 (dblib.c:2761):dbcount(0x7f4ae5dd5f50)
15:45:51.660839 34287 (dblib.c:1443):dbclose(0x7f4ae5dd5f50)
15:45:51.660850 34287 (dblib.c:258):dblib_del_connection(0x7f4ad67d0760, 0x7f4ae5eccf70)
15:45:51.660862 34287 (mem.c:615):tds_free_all_results()
15:45:51.661260 34287 (util.c:156):Changed query state from PENDING to DEAD
15:45:51.661390 34287 (dblib.c:305):dblib_release_tds_ctx(1)
15:45:51.661421 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5dd5f50)
15:45:51.661433 34287 (dblib.c:739):dbloginfree(0x7f4ae5dd7dc0)
15:45:51.661443 34287 (dblib.c:1512):dbexit(void)
15:45:51.661456 34287 (dblib.c:305):dblib_release_tds_ctx(1)
15:45:51.661599 34287 (dblib.c:670):dbinit(void)
15:45:51.661618 34287 (dblib.c:273):dblib_get_tds_ctx(void)
15:45:51.661630 34287 (locale.c:69):Attempting to read locales.conf file
15:45:51.661658 34287 (dblib.c:4945):dberrhandle(0x7f4ad67d2800)
15:45:51.661670 34287 (dblib.c:4964):dbmsghandle(0x7f4ad67d37b0)
15:45:51.661724 34287 (dblib.c:713):dblogin(void)
15:45:51.661739 34287 (dblib.c:761):dbsetlname(0x7f4ae5eee250, sa, 2)
15:45:51.661749 34287 (dblib.c:761):dbsetlname(0x7f4ae5eee250, not1common, 3)
15:45:51.661758 34287 (dblib.c:1146):dbopen(0x7f4ae5eee250, 10.15.2.70:5000, [sybase])
15:45:51.661769 34287 (dblib.c:273):dblib_get_tds_ctx(void)
15:45:51.661785 34287 (config.c:185):Getting connection information for [10.15.2.70:5000].
15:45:51.661791 34287 (config.c:189):Attempting to read conf files.
15:45:51.661797 34287 (config.c:354):... $FREETDSCONF not set. Trying $FREETDS/etc.
15:45:51.661802 34287 (config.c:367):... $FREETDS not set. Trying $HOME.
15:45:51.661862 34287 (config.c:293):Could not open '/var/lib/postgresql/.freetds.conf' ((.freetds.conf)).
15:45:51.661876 34287 (config.c:297):Found conf file '/etc/freetds/freetds.conf' (default).
15:45:51.661882 34287 (config.c:483):Looking for section global.
15:45:51.661911 34287 (config.c:540): Found section global.
15:45:51.661918 34287 (config.c:543):Got a match.
15:45:51.661925 34287 (config.c:565): dump file = '/tmp/freetds.log'
15:45:51.661931 34287 (config.c:565): debug flags = '0xffff'
15:45:51.661937 34287 (config.c:565): timeout = '30'
15:45:51.661943 34287 (config.c:565): connect timeout = '10'
15:45:51.661949 34287 (config.c:565): text size = '64512'
15:45:51.661955 34287 (config.c:540): Found section sybase.
15:45:51.661961 34287 (config.c:540): Found section egserver70.
15:45:51.661968 34287 (config.c:554): Reached EOF
15:45:51.661973 34287 (config.c:483):Looking for section 10.15.2.70:5000.
15:45:51.661980 34287 (config.c:540): Found section global.
15:45:51.661988 34287 (config.c:540): Found section sybase.
15:45:51.661994 34287 (config.c:540): Found section egserver70.
15:45:51.662000 34287 (config.c:554): Reached EOF
15:45:51.662004 34287 (config.c:303):[10.15.2.70:5000] not found.
15:45:51.662040 34287 (config.c:354):... $FREETDSCONF not set. Trying $FREETDS/etc.
15:45:51.662049 34287 (config.c:367):... $FREETDS not set. Trying $HOME.
15:45:51.662097 34287 (config.c:293):Could not open '/var/lib/postgresql/.freetds.conf' ((.freetds.conf)).
15:45:51.662120 34287 (config.c:297):Found conf file '/etc/freetds/freetds.conf' (default).
15:45:51.662132 34287 (config.c:483):Looking for section global.
15:45:51.662155 34287 (config.c:540): Found section global.
15:45:51.662168 34287 (config.c:543):Got a match.
15:45:51.662180 34287 (config.c:565): dump file = '/tmp/freetds.log'
15:45:51.662193 34287 (config.c:565): debug flags = '0xffff'
15:45:51.662206 34287 (config.c:565): timeout = '30'
15:45:51.662218 34287 (config.c:565): connect timeout = '10'
15:45:51.662229 34287 (config.c:565): text size = '64512'
15:45:51.662240 34287 (config.c:540): Found section sybase.
15:45:51.662253 34287 (config.c:540): Found section egserver70.
15:45:51.662267 34287 (config.c:554): Reached EOF
15:45:51.662278 34287 (config.c:483):Looking for section 10.15.2.70.
15:45:51.662292 34287 (config.c:540): Found section global.
15:45:51.662307 34287 (config.c:540): Found section sybase.
15:45:51.662319 34287 (config.c:540): Found section egserver70.
15:45:51.662329 34287 (config.c:554): Reached EOF
15:45:51.662337 34287 (config.c:303):[10.15.2.70] not found.
15:45:51.662364 34287 (iconv.c:330):tds_iconv_open(0x7f4ae5dd7d50, UTF-8)
15:45:51.662393 34287 (iconv.c:349):setting up conversions for client charset "UTF-8"
15:45:51.662398 34287 (iconv.c:351):preparing iconv for "UTF-8" <-> "UCS-2LE" conversion
15:45:51.662418 34287 (iconv.c:391):preparing iconv for "ISO-8859-1" <-> "ISO-8859-1" conversion
15:45:51.662425 34287 (iconv.c:394):tds_iconv_open: done
15:45:51.662432 34287 (net.c:205):Connecting to 10.15.2.70 port 5000 (TDS version 4.2)
15:45:51.662565 34287 (net.c:270):tds_open_socket: connect(2) returned "Operation now in progress"
15:45:51.781873 34287 (net.c:310):tds_open_socket() succeeded
15:45:51.781934 34287 (util.c:156):Changed query state from DEAD to IDLE
15:45:51.781993 34287 (net.c:741):Sending packet
0000 02 00 02 00 00 00 00 00-62 69 74 61 72 65 6e 61 |........ bitarena|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0020 00 00 00 00 00 00 08 73-61 00 00 00 00 00 00 00 |.......s a.......|
0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0040 00 00 00 00 00 02 6e 6f-74 31 63 6f 6d 6d 6f 6e |......no t1common|
0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0060 00 00 00 00 0a 33 34 32-38 37 00 00 00 00 00 00 |.....342 87......|
0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........|
0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00b0 00 00 00 31 30 2e 31 35-2e 32 2e 37 30 3a 35 30 |...10.15 .2.70:50|
00c0 30 30 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |00...... ........|
00d0 00 0f 6e 6f 74 31 63 6f-6d 6d 6f 6e 00 00 00 00 |..not1co mmon....|
00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01d0 00 0a 04 02 00 00 44 42-2d 4c 69 62 72 61 72 79 |......DB -Library|
01e0 0a 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli|
01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........|
15:45:51.782248 34287 (net.c:741):Sending packet
0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 75 74 66 |........ .....utf|
0020 38 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |8....... ........|
0030 00 00 00 00 00 00 00 00-00 00 00 04 01 35 31 32 |........ .....512|
0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....|
15:45:51.782395 34287 (token.c:328):tds_process_login_tokens()
15:45:51.912087 34287 (net.c:555):Received header
0000 04 01 00 70 00 00 00 00- |...p....|
15:45:51.912214 34287 (net.c:609):Received packet
0000 04 01 00 70 00 00 00 00-e3 0f 00 01 06 6d 61 73 |...p.... .....mas|
0010 74 65 72 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |ter.mast er.:.E..|
0020 00 02 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 6d 61 73 74 65 72-27 2e 0a 08 76 61 73 74 | 'master '...vast|
0050 67 5f 64 62 00 00 00 ad-0d 00 01 04 02 00 00 03 |g_db.... ........|
0060 41 53 45 0f 07 00 00 fd-00 00 02 00 5c 00 00 00 |ASE..... .......|
15:45:51.912284 34287 (token.c:337):looking for login token, got e3(ENVCHANGE)
15:45:51.912297 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.912315 34287 (dblib.c:327):db_env_chg(0x7f4ae5dd7d50, 1, master, master)
15:45:51.912329 34287 (token.c:337):looking for login token, got ab(INFO)
15:45:51.912339 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.912351 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.912367 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.912377 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5edcfd0, 0x7f4ae5dd7d50, 0x7ffffe5d9090)
15:45:51.912388 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'master'.
"
15:45:51.912839 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.912869 34287 (token.c:337):looking for login token, got ad(LOGINACK)
15:45:51.912881 34287 (token.c:373):server reports TDS version 4.2.0.0
15:45:51.912892 34287 (token.c:375):Product name for 0x4020000 is unknown
15:45:51.912905 34287 (token.c:337):looking for login token, got fd(DONE)
15:45:51.912916 34287 (token.c:122):tds_process_default_tokens() marker is fd(DONE)
15:45:51.912927 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.912938 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.912948 34287 (token.c:2370): rows_affected = 92
15:45:51.912958 34287 (token.c:438):tds_process_login_tokens() returning TDS_SUCCEED
15:45:51.913001 34287 (mem.c:615):tds_free_all_results()
15:45:51.913015 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.913027 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.913038 34287 (net.c:741):Sending packet
0000 01 01 00 1b 00 00 00 00-73 65 74 20 74 65 78 74 |........ set text|
0010 73 69 7a 65 20 36 34 35-31 32 20 |size 645 12 |
15:45:51.913302 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d91c8, 0x7ffffe5d91cc, 0x100)
15:45:51.913332 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.026788 34287 (net.c:555):Received header
0000 04 01 00 11 00 00 00 00- |........|
15:45:52.026862 34287 (net.c:609):Received packet
0000 04 01 00 11 00 00 00 00-fd 00 00 02 00 00 00 00 |........ ........|
0010 00 - |.|
15:45:52.026881 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:52.026894 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:52.026902 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:52.026910 34287 (util.c:156):Changed query state from READING to IDLE
15:45:52.026919 34287 (token.c:2370): rows_affected = 0
15:45:52.026927 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:52.026935 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d91c8, 0x7ffffe5d91cc, 0x100)
15:45:52.026944 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:52.026956 34287 (dblib.c:239):dblib_add_connection(0x7f4ad67d0760, 0x7f4ae5dd7d50)
15:45:52.027000 34287 (dblib.c:1398):dbuse(0x7f4ae5eccf70, sas_db)
15:45:52.027027 34287 (dblib.c:1312):dbcmd(0x7f4ae5eccf70, use [sas_db])
15:45:52.027041 34287 (dblib.c:1319):dbcmd() bufsz = 0
15:45:52.027052 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5eccf70)
15:45:52.027063 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5eccf70)
15:45:52.027074 34287 (mem.c:615):tds_free_all_results()
15:45:52.027085 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:52.027097 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:52.027107 34287 (net.c:741):Sending packet
0000 01 01 00 14 00 00 00 00-75 73 65 20 5b 73 61 73 |........ use [sas|
0010 5f 64 62 5d - |_db]|
15:45:52.027299 34287 (dblib.c:4639):dbsqlok(0x7f4ae5eccf70)
15:45:52.027327 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:52.027339 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d9628, 0x7ffffe5d962c, 0x6914)
15:45:52.027350 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.144390 34287 (net.c:555):Received header
0000 04 01 00 60 00 00 00 00- |...`....|
15:45:52.144481 34287 (net.c:609):Received packet
0000 04 01 00 60 00 00 00 00-e3 0f 00 01 06 73 61 73 |...`.... .....sas|
0010 5f 64 62 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |_db.mast er.:.E..|
0020 00 01 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 73 61 73 5f 64 62-27 2e 0a 08 76 61 73 74 | 'sas_db '...vast|
0050 67 5f 64 62 00 01 00 fd-00 00 02 00 00 00 00 00 |g_db.... ........|
15:45:52.144543 34287 (token.c:555):processing result tokens. marker is e3(ENVCHANGE)
15:45:52.144556 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:52.144574 34287 (dblib.c:327):db_env_chg(0x7f4ae5dd7d50, 1, master, sas_db)
15:45:52.144590 34287 (token.c:555):processing result tokens. marker is ab(INFO)
15:45:52.144601 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:52.144612 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:52.144626 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:52.144637 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5edcfd0, 0x7f4ae5dd7d50, 0x7ffffe5d9480)
15:45:52.144680 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'sas_db'.
"
15:45:52.145166 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:52.145204 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:52.145228 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:52.145252 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:52.145273 34287 (util.c:156):Changed query state from READING to IDLE
15:45:52.145291 34287 (token.c:2370): rows_affected = 0
15:45:52.145309 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:52.145321 34287 (dblib.c:4707):dbsqlok() end status is SUCCEED
15:45:52.145331 34287 (dblib.c:4718):dbsqlok() end status was success
15:45:52.145341 34287 (dblib.c:1668):dbresults(0x7f4ae5eccf70)
15:45:52.145352 34287 (dblib.c:1674):dbresults: dbresults_state is 5 (_DB_RES_SUCCEED)
15:45:52.145363 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:52.145373 34287 (dblib.c:5854):dbcanquery(0x7f4ae5eccf70)
15:45:52.145383 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d964c, (nil), 0x108)
15:45:52.145398 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:52.145516 34287 (dblib.c:1312):dbcmd(0x7f4ae5eccf70, select * from web_app.ApiSession)
15:45:52.145548 34287 (dblib.c:1319):dbcmd() bufsz = 13
15:45:52.145569 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5eccf70)
15:45:52.145591 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5eccf70)
15:45:52.145611 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5eccf70)
15:45:52.145632 34287 (mem.c:615):tds_free_all_results()
15:45:52.145653 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:52.145677 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:52.145698 34287 (net.c:741):Sending packet
0000 01 01 00 28 00 00 00 00-73 65 6c 65 63 74 20 2a |...(.... select *|
0010 20 66 72 6f 6d 20 77 65-62 5f 61 70 70 2e 41 70 | from we b_app.Ap|
0020 69 53 65 73 73 69 6f 6e- |iSession|
15:45:52.146241 34287 (dblib.c:4639):dbsqlok(0x7f4ae5eccf70)
15:45:52.146325 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:52.146359 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95b8, 0x7ffffe5d95bc, 0x6914)
15:45:52.146401 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.262567 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:52.262671 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-7c 73 0a 69 71 00 00 00 |........ |s.iq...|
0010 00 a0 96 00 0c 41 70 69-53 65 73 73 69 6f 6e 49 |.....Api SessionI|
0020 64 14 41 70 69 53 65 73-73 69 6f 6e 43 72 65 61 |d.ApiSes sionCrea|
0030 74 6f 72 55 49 44 14 41-64 6d 69 6e 69 73 74 72 |torUID.A dministr|
0040 61 74 6f 72 4c 6f 67 69-6e 49 64 10 4d 65 65 74 |atorLogi nId.Meet|
0050 69 6e 67 53 65 73 73 69-6f 6e 49 64 13 41 70 69 |ingSessi onId.Api|
0060 53 65 73 73 69 6f 6e 55-73 65 72 4e 6f 74 65 73 |SessionU serNotes|
0070 12 41 70 69 53 65 73 73-69 6f 6e 4d 6f 64 4e 6f |.ApiSess ionModNo|
0080 74 65 73 13 41 70 69 53-65 73 73 69 6f 6e 49 73 |tes.ApiS essionIs|
0090 44 65 6c 65 74 65 64 12-41 70 69 53 65 73 73 69 |Deleted. ApiSessi|
00a0 6f 6e 52 65 6d 6f 74 65-49 64 a1 60 00 2b 00 00 |onRemote Id.`.+..|
00b0 00 6d 08 23 00 00 00 e1-40 00 00 00 2b 00 00 00 |.m.#.... @...+...|
00c0 6d 08 2b 00 00 00 6d 08-14 00 00 00 22 00 fc 00 |m.+...m. ...."...|
00d0 00 12 00 77 65 62 5f 61-70 70 2e 41 70 69 53 65 |...web_a pp.ApiSe|
00e0 73 73 69 6f 6e 14 00 00-00 22 00 fc 00 00 12 00 |ssion... ."......|
00f0 77 65 62 5f 61 70 70 2e-41 70 69 53 65 73 73 69 |web_app. ApiSessi|
0100 6f 6e 10 00 00 00 32 2b-00 00 00 6d 08 ae 08 00 |on....2+ ...m....|
0110 00 00 00 00 00 00 00 00-d1 08 00 00 00 00 00 00 |........ ........|
0120 f0 3f 2a 00 00 00 62 00-72 00 75 00 63 00 65 00 |.?...b. r.u.c.e.|
0130 73 00 40 00 65 00 6c 00-6c 00 75 00 6d 00 69 00 |[email protected]. l.u.m.i.|
0140 6e 00 61 00 74 00 65 00-2e 00 63 00 6f 00 6d 00 |n.a.t.e. ..c.o.m.|
0150 08 00 00 00 00 28 cd 02-41 08 00 00 00 00 20 de |.....(.. A..... .|
0160 fd 40 10 5a 04 00 00 00-00 00 00 00 00 00 00 eb |[email protected].... ........|
0170 b0 4c 00 00 00 00 00 00-4c b0 eb 02 00 00 00 20 |.L...... L...... |
0180 00 10 5b 04 00 00 00 00-00 00 00 00 00 00 f2 b0 |..[..... ........|
0190 4c 00 00 00 00 00 00 4c-b0 f2 02 00 00 00 20 00 |L......L ...... .|
01a0 01 08 00 00 00 00 00 00-f0 3f d1 08 00 00 00 00 |........ .?......|
01b0 00 00 00 40 2a 00 00 00-62 00 72 00 75 00 63 00 |...@... b.r.u.c.|
01c0 65 00 73 00 40 00 65 00-6c 00 6c 00 75 00 6d 00 |[email protected]. l.l.u.m.|
01d0 69 00 6e 00 61 00 74 00-65 00 2e 00 63 00 6f 00 |i.n.a.t. e...c.o.|
01e0 6d 00 08 00 00 00 00 28-cd 02 41 08 00 00 00 00 |m......( ..A.....|
01f0 30 de fd 40 10 5c 04 00-00 00 00 00 00 00 00 00 |0..@... ........|
15:45:52.262963 34287 (token.c:555):processing result tokens. marker is 7c(PROCID)
15:45:52.262978 34287 (token.c:122):tds_process_default_tokens() marker is 7c(PROCID)
15:45:52.262990 34287 (token.c:555):processing result tokens. marker is a0(COLNAME)
15:45:52.263012 34287 (mem.c:615):tds_free_all_results()
15:45:52.263053 34287 (token.c:555):processing result tokens. marker is a1(COLFMT)
15:45:52.263069 34287 (token.c:1025):processing result. type = 109(float-null), varint_size 1
15:45:52.263082 34287 (token.c:1025):processing result. type = 35(text), varint_size 1
15:45:52.263148 34287 (token.c:3420):adjust_character_column_size:
Server charset: UTF-16LE
Server column_size: 64
Client charset: UTF-8
Client column_size: 128
15:45:52.263164 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263176 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263187 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263198 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263208 34287 (token.c:1025):processing result. type = 98(variant), varint_size 1
15:45:52.263219 34287 (token.c:1025):processing result. type = 65(), varint_size 1
15:45:52.263230 34287 (token.c:1053):NOTE:tds_process_col_fmt: draining 48 bytes
15:45:52.263242 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.263255 34287 (dblib.c:4700):dbsqlok() found result token
15:45:52.263267 34287 (dblib.c:1668):dbresults(0x7f4ae5eccf70)
15:45:52.263278 34287 (dblib.c:1674):dbresults: dbresults_state is 1 (_DB_RES_RESULTSET_EMPTY)
15:45:52.263288 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95a8, 0x7ffffe5d95ac, 0x6914)
15:45:52.263299 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.263309 34287 (token.c:555):processing result tokens. marker is ae(CONTROL)
15:45:52.263319 34287 (token.c:122):tds_process_default_tokens() marker is ae(CONTROL)
15:45:52.263330 34287 (token.c:237):Eating CONTROL token
15:45:52.263340 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:52.263351 34287 (token.c:666):tds_process_tokens::SET_RETURN stopping on current token
15:45:52.263361 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.263371 34287 (dblib.c:1695):dbresults() tds_process_tokens returned 1 (TDS_SUCCEED),
result_type TDS_ROW_RESULT
15:45:52.263382 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:52.263392 34287 (dblib.c:2018):dbnextrow(0x7f4ae5eccf70)
15:45:52.263402 34287 (dblib.c:2031):dbnextrow() dbresults_state = 2 (_DB_RES_RESULTSET_ROWS)
15:45:52.263412 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95bc, (nil), 0x1508)
15:45:52.263426 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.263435 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:52.263446 34287 (token.c:2304):tds_process_row(): reading column 0
15:45:52.263456 34287 (token.c:2049):tds_get_data: type 109, varint size 1
15:45:52.263466 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:52.263476 34287 (token.c:2304):tds_process_row(): reading column 1
15:45:52.263486 34287 (token.c:2049):tds_get_data: type 35, varint size 1
15:45:52.263510 34287 (token.c:2110):tds_get_data(): wire column size is 42
15:45:52.263528 34287 (token.c:2304):tds_process_row(): reading column 2
15:45:52.263539 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263549 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:52.263559 34287 (token.c:2304):tds_process_row(): reading column 3
15:45:52.263568 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263577 34287 (token.c:2110):tds_get_data(): wire column size is 109
15:45:52.263587 34287 (token.c:2304):tds_process_row(): reading column 4
15:45:52.263597 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263606 34287 (token.c:2110):tds_get_data(): wire column size is 117
15:45:52.265020 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:52.265047 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-00 fb b0 4c 00 00 00 00 |........ ...L....|
0010 00 00 4c b0 fb 02 00 00-00 20 00 10 5d 04 00 00 |..L..... . ..]...|
0020 00 00 00 00 00 00 00 00-02 b1 4c 00 00 00 00 00 |........ ..L.....|
0030 00 4c b1 02 02 00 00 00-20 00 00 08 00 00 00 00 |.L...... .......|
0040 00 00 00 40 d1 08 00 00-00 00 00 00 08 40 2a 00 |...@.... .....@.|
0050 00 00 62 00 72 00 75 00-63 00 65 00 73 00 40 00 |..b.r.u. c.e.s.@.|
0060 65 00 6c 00 6c 00 75 00-6d 00 69 00 6e 00 61 00 |e.l.l.u. m.i.n.a.|
0070 74 00 65 00 2e 00 63 00-6f 00 6d 00 08 00 00 00 |t.e...c. o.m.....|
0080 00 28 cd 02 41 08 00 00-00 00 40 de fd 40 10 5e |.(..A... ..@..@.^|
0090 04 00 00 00 00 00 00 00-00 00 00 0b b1 4c 00 00 |........ .....L..|
00a0 00 00 00 00 4c b1 0b 02-00 00 00 20 00 10 5f 04 |....L... ... ...|
00b0 00 00 00 00 00 00 00 00-00 00 12 b1 4c 00 00 00 |........ ....L...|
00c0 00 00 00 4c b1 12 02 00-00 00 20 00 00 08 00 00 |...L.... .. .....|
00d0 00 00 00 00 08 40 d1 08-00 00 00 00 00 00 10 40 |.....@.. .......@|
00e0 2a 00 00 00 62 00 72 00-75 00 63 00 65 00 73 00 |_...b.r. u.c.e.s.|
00f0 40 00 65 00 6c 00 6c 00-75 00 6d 00 69 00 6e 00 |@.e.l.l. u.m.i.n.|
0100 61 00 74 00 65 00 2e 00-63 00 6f 00 6d 00 08 00 |a.t.e... c.o.m...|
0110 00 00 00 28 cd 02 41 08-00 00 00 00 40 ab fe 40 |...(..A. ....@..@|
0120 10 80 01 23 00 00 00 00-00 00 00 00 00 1b b1 4c |...#.... .......L|
0130 00 00 00 00 00 00 4c b1-1b 02 00 00 00 20 00 10 |......L. ..... ..|
0140 81 01 23 00 00 00 00 00-00 00 00 00 23 b1 4c 00 |..#..... ....#.L.|
0150 00 00 00 00 00 4c b1 23-02 00 00 00 20 00 00 08 |.....L.# .... ...|
0160 00 00 00 00 00 00 10 40-d1 08 00 00 00 00 00 00 |.......@ ........|
0170 24 40 12 00 00 00 75 00-69 00 67 00 63 00 61 00 |[email protected]. i.g.c.a.|
0180 64 00 6d 00 69 00 6e 00-08 00 00 00 00 68 14 03 |d.m.i.n. .....h..|
0190 41 08 00 00 00 00 18 24-00 41 10 82 01 23 00 00 |A......$ .A...#..|
01a0 00 00 00 00 00 00 00 2b-b1 4c 00 00 00 00 00 00 |.......+ .L......|
01b0 4c b1 2b 02 00 00 00 20-00 10 83 01 23 00 00 00 |L.+.... ....#...|
01c0 00 00 00 00 00 00 32 b1-4c 00 00 00 00 00 00 4c |......2. L......L|
01d0 b1 32 02 00 00 00 20 00-00 08 00 00 00 00 00 00 |.2.... . ........|
01e0 24 40 d1 08 00 00 00 00-00 00 26 40 12 00 00 00 |$@...... ..&@....|
01f0 75 00 69 00 67 00 63 00-61 00 64 00 6d 00 69 00 |u.i.g.c. a.d.m.i.|
15:45:52.265173 34287 (token.c:2304):tds_process_row(): reading column 5
15:45:52.265180 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.265190 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:52.265200 34287 (token.c:2304):tds_process_row(): reading column 6
15:45:52.265210 34287 (token.c:2049):tds_get_data: type 98, varint size 1
15:45:52.265220 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:52.265231 34287 (token.c:2304):tds_process_row(): reading column 7
15:45:52.265241 34287 (token.c:2049):tds_get_data: type 65, varint size 1
15:45:52.265250 34287 (token.c:2110):tds_get_data(): wire column size is 209
15:45:52.265258 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.265268 34287 (buffering.h:306):buffer_transfer_bound_data(0x7f4ae5eccf80 4040 -1 0x7f4ae5eccf70 0)
15:45:52.265286 34287 (dblib.c:2100):leaving dbnextrow() returning REG_ROW/MORE_ROWS
15:45:52.265292 34287 (dblib.c:1813):dbnumcols(0x7f4ae5eccf70)
15:45:52.265305 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 1)
15:45:52.265317 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 1)
15:45:52.265322 34287 (dblib.c:3142):dbdatlen() type = 109, len= 8
15:45:52.265328 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 1)
15:45:52.265333 34287 (dblib.c:2812):dbwillconvert(SYBFLT8, SYBCHAR)
15:45:52.265340 34287 (convert.c:2788):tds_willconvert(62, 47)
15:45:52.265348 34287 (convert.c:2792):tds_willconvert(62, 47) returns yes
15:45:52.265356 34287 (dblib.c:2217):dbconvert(0x7f4ae5eccf70, SYBFLT8, 0x7f4ae5ef1020, 8, SYBCHAR, 0x7f4ae5f076a0, -1)
15:45:52.265361 34287 (dblib.c:2349):dbconvert() calling tds_convert
15:45:52.265383 34287 (dblib.c:2352):dbconvert() called tds_convert returned 1
15:45:52.265389 34287 (dblib.c:2455):dbconvert() outputting 1 bytes character data destlen = -1
15:45:52.265395 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 2)
15:45:52.265400 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 2)
15:45:52.265405 34287 (dblib.c:3142):dbdatlen() type = 35, len= 61
15:45:52.265409 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 2)
15:45:52.265414 34287 (dblib.c:2812):dbwillconvert(SYBTEXT, SYBCHAR)
15:45:52.265419 34287 (convert.c:2788):tds_willconvert(35, 47)
15:45:52.265424 34287 (convert.c:2792):tds_willconvert(35, 47) returns yes
15:45:52.265429 34287 (dblib.c:2217):dbconvert(0x7f4ae5eccf70, SYBTEXT, 0x7f4ae5ef1028, 61, SYBCHAR, 0x7f4ae5f07ab0, -1)
15:45:52.265434 34287 (dblib.c:2349):dbconvert() calling tds_convert
15:45:52.265442 34287 (dblib.c:2352):dbconvert() called tds_convert returned 61
15:45:52.265447 34287 (dblib.c:2455):dbconvert() outputting 61 bytes character data destlen = -1
15:45:52.265452 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 3)
15:45:52.265457 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 3)
15:45:52.265462 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265467 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 3)
15:45:52.265471 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 4)
15:45:52.265476 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 4)
15:45:52.265481 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265485 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 4)
15:45:52.265490 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 5)
15:45:52.265494 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 5)
15:45:52.265499 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265504 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 5)
15:45:52.265509 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 6)
15:45:52.265513 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 6)
15:45:52.265518 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265522 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 6)
15:45:52.265527 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 7)
15:45:52.265532 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 7)
15:45:52.265536 34287 (dblib.c:3142):dbdatlen() type = 98, len= 8
15:45:52.265541 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 7)
15:45:52.265545 34287 (dblib.c:2812):dbwillconvert(SYBVARIANT, SYBCHAR)
15:45:52.265550 34287 (convert.c:2788):tds_willconvert(98, 47)
15:45:52.265555 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 8)
15:45:52.265560 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 8)
15:45:52.265565 34287 (dblib.c:3142):dbdatlen() type = 65, len= 112
15:45:52.265569 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 8)
15:45:52.265574 34287 (dblib.c:2812):dbwillconvert(SYBUINT2, SYBCHAR)
15:45:52.265579 34287 (convert.c:2788):tds_willconvert(65, 47)
postgres@bitarena:$ clear
postgres@bitarena:$ cat /tmp/freetds.log
15:45:51.071682 34287 (log.c:196):Starting log file for FreeTDS 0.91
on 2014-05-28 15:45:51 with debug flags 0xffff.
15:45:51.071736 34287 (iconv.c:330):tds_iconv_open(0x7f4ae5eccf70, UTF-8)
15:45:51.071925 34287 (iconv.c:187):local name for ISO-8859-1 is ISO-8859-1
15:45:51.071943 34287 (iconv.c:187):local name for UTF-8 is UTF-8
15:45:51.071951 34287 (iconv.c:187):local name for UCS-2LE is UCS-2LE
15:45:51.071959 34287 (iconv.c:187):local name for UCS-2BE is UCS-2BE
15:45:51.071967 34287 (iconv.c:349):setting up conversions for client charset "UTF-8"
15:45:51.071974 34287 (iconv.c:351):preparing iconv for "UTF-8" <-> "UCS-2LE" conversion
15:45:51.071992 34287 (iconv.c:391):preparing iconv for "ISO-8859-1" <-> "ISO-8859-1" conversion
15:45:51.072001 34287 (iconv.c:394):tds_iconv_open: done
15:45:51.072018 34287 (net.c:205):Connecting to 10.15.2.70 port 5000 (TDS version 4.2)
15:45:51.072229 34287 (net.c:270):tds_open_socket: connect(2) returned "Operation now in progress"
15:45:51.187342 34287 (net.c:310):tds_open_socket() succeeded
15:45:51.187427 34287 (util.c:156):Changed query state from DEAD to IDLE
15:45:51.187457 34287 (net.c:741):Sending packet
0000 02 00 02 00 00 00 00 00-62 69 74 61 72 65 6e 61 |........ bitarena|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0020 00 00 00 00 00 00 08 73-61 00 00 00 00 00 00 00 |.......s a.......|
0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0040 00 00 00 00 00 02 6e 6f-74 31 63 6f 6d 6d 6f 6e |......no t1common|
0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0060 00 00 00 00 0a 33 34 32-38 37 00 00 00 00 00 00 |.....342 87......|
0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........|
0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00b0 00 00 00 31 30 2e 31 35-2e 32 2e 37 30 3a 35 30 |...10.15 .2.70:50|
00c0 30 30 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |00...... ........|
00d0 00 0f 6e 6f 74 31 63 6f-6d 6d 6f 6e 00 00 00 00 |..not1co mmon....|
00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01d0 00 0a 04 02 00 00 44 42-2d 4c 69 62 72 61 72 79 |......DB -Library|
01e0 0a 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli|
01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........|
15:45:51.187751 34287 (net.c:741):Sending packet
0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 75 74 66 |........ .....utf|
0020 38 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |8....... ........|
0030 00 00 00 00 00 00 00 00-00 00 00 04 01 35 31 32 |........ .....512|
0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....|
15:45:51.187930 34287 (token.c:328):tds_process_login_tokens()
15:45:51.314519 34287 (net.c:555):Received header
0000 04 01 00 70 00 00 00 00- |...p....|
15:45:51.314647 34287 (net.c:609):Received packet
0000 04 01 00 70 00 00 00 00-e3 0f 00 01 06 6d 61 73 |...p.... .....mas|
0010 74 65 72 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |ter.mast er.:.E..|
0020 00 02 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 6d 61 73 74 65 72-27 2e 0a 08 76 61 73 74 | 'master '...vast|
0050 67 5f 64 62 00 00 00 ad-0d 00 01 04 02 00 00 03 |g_db.... ........|
0060 41 53 45 0f 07 00 00 fd-00 00 02 00 33 00 00 00 |ASE..... ....3...|
15:45:51.314718 34287 (token.c:337):looking for login token, got e3(ENVCHANGE)
15:45:51.314742 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.314774 34287 (dblib.c:327):db_env_chg(0x7f4ae5eccf70, 1, master, master)
15:45:51.314792 34287 (token.c:337):looking for login token, got ab(INFO)
15:45:51.314803 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.314814 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.314831 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.314843 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5dd7d70, 0x7f4ae5eccf70, 0x7ffffe5d8df0)
15:45:51.314854 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'master'.
"
15:45:51.315037 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.315059 34287 (token.c:337):looking for login token, got ad(LOGINACK)
15:45:51.315071 34287 (token.c:373):server reports TDS version 4.2.0.0
15:45:51.315083 34287 (token.c:375):Product name for 0x4020000 is unknown
15:45:51.315096 34287 (token.c:337):looking for login token, got fd(DONE)
15:45:51.315106 34287 (token.c:122):tds_process_default_tokens() marker is fd(DONE)
15:45:51.315122 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.315135 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.315145 34287 (token.c:2370): rows_affected = 51
15:45:51.315156 34287 (token.c:438):tds_process_login_tokens() returning TDS_SUCCEED
15:45:51.315178 34287 (mem.c:615):tds_free_all_results()
15:45:51.315190 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.315205 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.315216 34287 (net.c:741):Sending packet
0000 01 01 00 1b 00 00 00 00-73 65 74 20 74 65 78 74 |........ set text|
0010 73 69 7a 65 20 36 34 35-31 32 20 |size 645 12 |
15:45:51.315386 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d8f28, 0x7ffffe5d8f2c, 0x100)
15:45:51.315413 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.426652 34287 (net.c:555):Received header
0000 04 01 00 11 00 00 00 00- |........|
15:45:51.426750 34287 (net.c:609):Received packet
0000 04 01 00 11 00 00 00 00-fd 00 00 02 00 00 00 00 |........ ........|
0010 00 - |.|
15:45:51.426776 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:51.426792 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.426804 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.426815 34287 (util.c:156):Changed query state from READING to IDLE
15:45:51.426826 34287 (token.c:2370): rows_affected = 0
15:45:51.426837 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:51.426847 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d8f28, 0x7ffffe5d8f2c, 0x100)
15:45:51.426859 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:51.426875 34287 (dblib.c:239):dblib_add_connection(0x7f4ad67d0760, 0x7f4ae5eccf70)
15:45:51.426892 34287 (dblib.c:1398):dbuse(0x7f4ae5dd5f50, sas_db)
15:45:51.426907 34287 (dblib.c:1312):dbcmd(0x7f4ae5dd5f50, use [sas_db])
15:45:51.426927 34287 (dblib.c:1319):dbcmd() bufsz = 0
15:45:51.426936 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5dd5f50)
15:45:51.426977 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5dd5f50)
15:45:51.426988 34287 (mem.c:615):tds_free_all_results()
15:45:51.426996 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.427005 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.427013 34287 (net.c:741):Sending packet
0000 01 01 00 14 00 00 00 00-75 73 65 20 5b 73 61 73 |........ use [sas|
0010 5f 64 62 5d - |_db]|
15:45:51.427191 34287 (dblib.c:4639):dbsqlok(0x7f4ae5dd5f50)
15:45:51.427211 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:51.427219 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d9388, 0x7ffffe5d938c, 0x6914)
15:45:51.427228 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.541554 34287 (net.c:555):Received header
0000 04 01 00 60 00 00 00 00- |...`....|
15:45:51.541627 34287 (net.c:609):Received packet
0000 04 01 00 60 00 00 00 00-e3 0f 00 01 06 73 61 73 |...`.... .....sas|
0010 5f 64 62 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |_db.mast er.:.E..|
0020 00 01 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 73 61 73 5f 64 62-27 2e 0a 08 76 61 73 74 | 'sas_db '...vast|
0050 67 5f 64 62 00 01 00 fd-00 00 02 00 00 00 00 00 |g_db.... ........|
15:45:51.541673 34287 (token.c:555):processing result tokens. marker is e3(ENVCHANGE)
15:45:51.541683 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.541695 34287 (dblib.c:327):db_env_chg(0x7f4ae5eccf70, 1, master, sas_db)
15:45:51.541706 34287 (token.c:555):processing result tokens. marker is ab(INFO)
15:45:51.541714 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.541722 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.541733 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.541741 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5dd7d70, 0x7f4ae5eccf70, 0x7ffffe5d91e0)
15:45:51.541750 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'sas_db'.
"
15:45:51.542038 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.542067 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:51.542078 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.542087 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.542094 34287 (util.c:156):Changed query state from READING to IDLE
15:45:51.542102 34287 (token.c:2370): rows_affected = 0
15:45:51.542109 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:51.542125 34287 (dblib.c:4707):dbsqlok() end status is SUCCEED
15:45:51.542134 34287 (dblib.c:4718):dbsqlok() end status was success
15:45:51.542144 34287 (dblib.c:1668):dbresults(0x7f4ae5dd5f50)
15:45:51.542153 34287 (dblib.c:1674):dbresults: dbresults_state is 5 (_DB_RES_SUCCEED)
15:45:51.542161 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:51.542169 34287 (dblib.c:5854):dbcanquery(0x7f4ae5dd5f50)
15:45:51.542176 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93ac, (nil), 0x108)
15:45:51.542222 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:51.542232 34287 (dblib.c:1312):dbcmd(0x7f4ae5dd5f50, select * from web_app.ApiSession)
15:45:51.542240 34287 (dblib.c:1319):dbcmd() bufsz = 13
15:45:51.542247 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5dd5f50)
15:45:51.542255 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5dd5f50)
15:45:51.542263 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5dd5f50)
15:45:51.542272 34287 (mem.c:615):tds_free_all_results()
15:45:51.542280 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.542289 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.542297 34287 (net.c:741):Sending packet
0000 01 01 00 28 00 00 00 00-73 65 6c 65 63 74 20 2a |...(.... select *|
0010 20 66 72 6f 6d 20 77 65-62 5f 61 70 70 2e 41 70 | from we b_app.Ap|
0020 69 53 65 73 73 69 6f 6e- |iSession|
15:45:51.542470 34287 (dblib.c:4639):dbsqlok(0x7f4ae5dd5f50)
15:45:51.542490 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:51.542498 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93e8, 0x7ffffe5d93ec, 0x6914)
15:45:51.542507 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.656744 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:51.656815 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-7c 73 0a 69 71 00 00 00 |........ |s.iq...|
0010 00 a0 96 00 0c 41 70 69-53 65 73 73 69 6f 6e 49 |.....Api SessionI|
0020 64 14 41 70 69 53 65 73-73 69 6f 6e 43 72 65 61 |d.ApiSes sionCrea|
0030 74 6f 72 55 49 44 14 41-64 6d 69 6e 69 73 74 72 |torUID.A dministr|
0040 61 74 6f 72 4c 6f 67 69-6e 49 64 10 4d 65 65 74 |atorLogi nId.Meet|
0050 69 6e 67 53 65 73 73 69-6f 6e 49 64 13 41 70 69 |ingSessi onId.Api|
0060 53 65 73 73 69 6f 6e 55-73 65 72 4e 6f 74 65 73 |SessionU serNotes|
0070 12 41 70 69 53 65 73 73-69 6f 6e 4d 6f 64 4e 6f |.ApiSess ionModNo|
0080 74 65 73 13 41 70 69 53-65 73 73 69 6f 6e 49 73 |tes.ApiS essionIs|
0090 44 65 6c 65 74 65 64 12-41 70 69 53 65 73 73 69 |Deleted. ApiSessi|
00a0 6f 6e 52 65 6d 6f 74 65-49 64 a1 60 00 2b 00 00 |onRemote Id.`.+..|
00b0 00 6d 08 23 00 00 00 e1-40 00 00 00 2b 00 00 00 |.m.#.... @...+...|
00c0 6d 08 2b 00 00 00 6d 08-14 00 00 00 22 00 fc 00 |m.+...m. ...."...|
00d0 00 12 00 77 65 62 5f 61-70 70 2e 41 70 69 53 65 |...web_a pp.ApiSe|
00e0 73 73 69 6f 6e 14 00 00-00 22 00 fc 00 00 12 00 |ssion... ."......|
00f0 77 65 62 5f 61 70 70 2e-41 70 69 53 65 73 73 69 |web_app. ApiSessi|
0100 6f 6e 10 00 00 00 32 2b-00 00 00 6d 08 ae 08 00 |on....2+ ...m....|
0110 00 00 00 00 00 00 00 00-d1 08 00 00 00 00 00 00 |........ ........|
0120 f0 3f 2a 00 00 00 62 00-72 00 75 00 63 00 65 00 |.?...b. r.u.c.e.|
0130 73 00 40 00 65 00 6c 00-6c 00 75 00 6d 00 69 00 |[email protected]. l.u.m.i.|
0140 6e 00 61 00 74 00 65 00-2e 00 63 00 6f 00 6d 00 |n.a.t.e. ..c.o.m.|
0150 08 00 00 00 00 28 cd 02-41 08 00 00 00 00 20 de |.....(.. A..... .|
0160 fd 40 10 5a 04 00 00 00-00 00 00 00 00 00 00 eb |[email protected].... ........|
0170 b0 4c 00 00 00 00 00 00-4c b0 eb 02 00 00 00 20 |.L...... L...... |
0180 00 10 5b 04 00 00 00 00-00 00 00 00 00 00 f2 b0 |..[..... ........|
0190 4c 00 00 00 00 00 00 4c-b0 f2 02 00 00 00 20 00 |L......L ...... .|
01a0 01 08 00 00 00 00 00 00-f0 3f d1 08 00 00 00 00 |........ .?......|
01b0 00 00 00 40 2a 00 00 00-62 00 72 00 75 00 63 00 |...@... b.r.u.c.|
01c0 65 00 73 00 40 00 65 00-6c 00 6c 00 75 00 6d 00 |[email protected]. l.l.u.m.|
01d0 69 00 6e 00 61 00 74 00-65 00 2e 00 63 00 6f 00 |i.n.a.t. e...c.o.|
01e0 6d 00 08 00 00 00 00 28-cd 02 41 08 00 00 00 00 |m......( ..A.....|
01f0 30 de fd 40 10 5c 04 00-00 00 00 00 00 00 00 00 |0..@... ........|
15:45:51.656965 34287 (token.c:555):processing result tokens. marker is 7c(PROCID)
15:45:51.656973 34287 (token.c:122):tds_process_default_tokens() marker is 7c(PROCID)
15:45:51.656980 34287 (token.c:555):processing result tokens. marker is a0(COLNAME)
15:45:51.656993 34287 (mem.c:615):tds_free_all_results()
15:45:51.657024 34287 (token.c:555):processing result tokens. marker is a1(COLFMT)
15:45:51.657034 34287 (token.c:1025):processing result. type = 109(float-null), varint_size 1
15:45:51.657042 34287 (token.c:1025):processing result. type = 35(text), varint_size 1
15:45:51.657258 34287 (token.c:3420):adjust_character_column_size:
Server charset: UTF-16LE
Server column_size: 64
Client charset: UTF-8
Client column_size: 128
15:45:51.657274 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657282 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657289 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657296 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:51.657302 34287 (token.c:1025):processing result. type = 98(variant), varint_size 1
15:45:51.657325 34287 (token.c:1025):processing result. type = 65(), varint_size 1
15:45:51.657333 34287 (token.c:1053):NOTE:tds_process_col_fmt: draining 48 bytes
15:45:51.657341 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.657350 34287 (dblib.c:4700):dbsqlok() found result token
15:45:51.657357 34287 (dblib.c:1668):dbresults(0x7f4ae5dd5f50)
15:45:51.657364 34287 (dblib.c:1674):dbresults: dbresults_state is 1 (_DB_RES_RESULTSET_EMPTY)
15:45:51.657371 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93d8, 0x7ffffe5d93dc, 0x6914)
15:45:51.657378 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.657384 34287 (token.c:555):processing result tokens. marker is ae(CONTROL)
15:45:51.657391 34287 (token.c:122):tds_process_default_tokens() marker is ae(CONTROL)
15:45:51.657397 34287 (token.c:237):Eating CONTROL token
15:45:51.657404 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:51.657411 34287 (token.c:666):tds_process_tokens::SET_RETURN stopping on current token
15:45:51.657417 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.657423 34287 (dblib.c:1695):dbresults() tds_process_tokens returned 1 (TDS_SUCCEED),
result_type TDS_ROW_RESULT
15:45:51.657430 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:51.657441 34287 (dblib.c:2018):dbnextrow(0x7f4ae5dd5f50)
15:45:51.657448 34287 (dblib.c:2031):dbnextrow() dbresults_state = 2 (_DB_RES_RESULTSET_ROWS)
15:45:51.657455 34287 (token.c:540):tds_process_tokens(0x7f4ae5eccf70, 0x7ffffe5d93ec, (nil), 0x1508)
15:45:51.657464 34287 (util.c:156):Changed query state from PENDING to READING
15:45:51.657470 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:51.657477 34287 (token.c:2304):tds_process_row(): reading column 0
15:45:51.657483 34287 (token.c:2049):tds_get_data: type 109, varint size 1
15:45:51.657490 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:51.657496 34287 (token.c:2304):tds_process_row(): reading column 1
15:45:51.657502 34287 (token.c:2049):tds_get_data: type 35, varint size 1
15:45:51.657508 34287 (token.c:2110):tds_get_data(): wire column size is 42
15:45:51.657522 34287 (token.c:2304):tds_process_row(): reading column 2
15:45:51.657529 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657535 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:51.657541 34287 (token.c:2304):tds_process_row(): reading column 3
15:45:51.657547 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657553 34287 (token.c:2110):tds_get_data(): wire column size is 109
15:45:51.657560 34287 (token.c:2304):tds_process_row(): reading column 4
15:45:51.657566 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.657572 34287 (token.c:2110):tds_get_data(): wire column size is 117
15:45:51.660163 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:51.660215 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-00 fb b0 4c 00 00 00 00 |........ ...L....|
0010 00 00 4c b0 fb 02 00 00-00 20 00 10 5d 04 00 00 |..L..... . ..]...|
0020 00 00 00 00 00 00 00 00-02 b1 4c 00 00 00 00 00 |........ ..L.....|
0030 00 4c b1 02 02 00 00 00-20 00 00 08 00 00 00 00 |.L...... .......|
0040 00 00 00 40 d1 08 00 00-00 00 00 00 08 40 2a 00 |...@.... .....@.|
0050 00 00 62 00 72 00 75 00-63 00 65 00 73 00 40 00 |..b.r.u. c.e.s.@.|
0060 65 00 6c 00 6c 00 75 00-6d 00 69 00 6e 00 61 00 |e.l.l.u. m.i.n.a.|
0070 74 00 65 00 2e 00 63 00-6f 00 6d 00 08 00 00 00 |t.e...c. o.m.....|
0080 00 28 cd 02 41 08 00 00-00 00 40 de fd 40 10 5e |.(..A... ..@..@.^|
0090 04 00 00 00 00 00 00 00-00 00 00 0b b1 4c 00 00 |........ .....L..|
00a0 00 00 00 00 4c b1 0b 02-00 00 00 20 00 10 5f 04 |....L... ... ...|
00b0 00 00 00 00 00 00 00 00-00 00 12 b1 4c 00 00 00 |........ ....L...|
00c0 00 00 00 4c b1 12 02 00-00 00 20 00 00 08 00 00 |...L.... .. .....|
00d0 00 00 00 00 08 40 d1 08-00 00 00 00 00 00 10 40 |.....@.. .......@|
00e0 2a 00 00 00 62 00 72 00-75 00 63 00 65 00 73 00 |_...b.r. u.c.e.s.|
00f0 40 00 65 00 6c 00 6c 00-75 00 6d 00 69 00 6e 00 |@.e.l.l. u.m.i.n.|
0100 61 00 74 00 65 00 2e 00-63 00 6f 00 6d 00 08 00 |a.t.e... c.o.m...|
0110 00 00 00 28 cd 02 41 08-00 00 00 00 40 ab fe 40 |...(..A. ....@..@|
0120 10 80 01 23 00 00 00 00-00 00 00 00 00 1b b1 4c |...#.... .......L|
0130 00 00 00 00 00 00 4c b1-1b 02 00 00 00 20 00 10 |......L. ..... ..|
0140 81 01 23 00 00 00 00 00-00 00 00 00 23 b1 4c 00 |..#..... ....#.L.|
0150 00 00 00 00 00 4c b1 23-02 00 00 00 20 00 00 08 |.....L.# .... ...|
0160 00 00 00 00 00 00 10 40-d1 08 00 00 00 00 00 00 |.......@ ........|
0170 24 40 12 00 00 00 75 00-69 00 67 00 63 00 61 00 |[email protected]. i.g.c.a.|
0180 64 00 6d 00 69 00 6e 00-08 00 00 00 00 68 14 03 |d.m.i.n. .....h..|
0190 41 08 00 00 00 00 18 24-00 41 10 82 01 23 00 00 |A......$ .A...#..|
01a0 00 00 00 00 00 00 00 2b-b1 4c 00 00 00 00 00 00 |.......+ .L......|
01b0 4c b1 2b 02 00 00 00 20-00 10 83 01 23 00 00 00 |L.+.... ....#...|
01c0 00 00 00 00 00 00 32 b1-4c 00 00 00 00 00 00 4c |......2. L......L|
01d0 b1 32 02 00 00 00 20 00-00 08 00 00 00 00 00 00 |.2.... . ........|
01e0 24 40 d1 08 00 00 00 00-00 00 26 40 12 00 00 00 |$@...... ..&@....|
01f0 75 00 69 00 67 00 63 00-61 00 64 00 6d 00 69 00 |u.i.g.c. a.d.m.i.|
15:45:51.660685 34287 (token.c:2304):tds_process_row(): reading column 5
15:45:51.660701 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:51.660711 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:51.660721 34287 (token.c:2304):tds_process_row(): reading column 6
15:45:51.660731 34287 (token.c:2049):tds_get_data: type 98, varint size 1
15:45:51.660741 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:51.660752 34287 (token.c:2304):tds_process_row(): reading column 7
15:45:51.660763 34287 (token.c:2049):tds_get_data: type 65, varint size 1
15:45:51.660772 34287 (token.c:2110):tds_get_data(): wire column size is 209
15:45:51.660782 34287 (util.c:156):Changed query state from READING to PENDING
15:45:51.660799 34287 (buffering.h:306):buffer_transfer_bound_data(0x7f4ae5dd5f60 4040 -1 0x7f4ae5dd5f50 0)
15:45:51.660814 34287 (dblib.c:2100):leaving dbnextrow() returning REG_ROW/MORE_ROWS
15:45:51.660828 34287 (dblib.c:2761):dbcount(0x7f4ae5dd5f50)
15:45:51.660839 34287 (dblib.c:1443):dbclose(0x7f4ae5dd5f50)
15:45:51.660850 34287 (dblib.c:258):dblib_del_connection(0x7f4ad67d0760, 0x7f4ae5eccf70)
15:45:51.660862 34287 (mem.c:615):tds_free_all_results()
15:45:51.661260 34287 (util.c:156):Changed query state from PENDING to DEAD
15:45:51.661390 34287 (dblib.c:305):dblib_release_tds_ctx(1)
15:45:51.661421 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5dd5f50)
15:45:51.661433 34287 (dblib.c:739):dbloginfree(0x7f4ae5dd7dc0)
15:45:51.661443 34287 (dblib.c:1512):dbexit(void)
15:45:51.661456 34287 (dblib.c:305):dblib_release_tds_ctx(1)
15:45:51.661599 34287 (dblib.c:670):dbinit(void)
15:45:51.661618 34287 (dblib.c:273):dblib_get_tds_ctx(void)
15:45:51.661630 34287 (locale.c:69):Attempting to read locales.conf file
15:45:51.661658 34287 (dblib.c:4945):dberrhandle(0x7f4ad67d2800)
15:45:51.661670 34287 (dblib.c:4964):dbmsghandle(0x7f4ad67d37b0)
15:45:51.661724 34287 (dblib.c:713):dblogin(void)
15:45:51.661739 34287 (dblib.c:761):dbsetlname(0x7f4ae5eee250, sa, 2)
15:45:51.661749 34287 (dblib.c:761):dbsetlname(0x7f4ae5eee250, not1common, 3)
15:45:51.661758 34287 (dblib.c:1146):dbopen(0x7f4ae5eee250, 10.15.2.70:5000, [sybase])
15:45:51.661769 34287 (dblib.c:273):dblib_get_tds_ctx(void)
15:45:51.661785 34287 (config.c:185):Getting connection information for [10.15.2.70:5000].
15:45:51.661791 34287 (config.c:189):Attempting to read conf files.
15:45:51.661797 34287 (config.c:354):... $FREETDSCONF not set. Trying $FREETDS/etc.
15:45:51.661802 34287 (config.c:367):... $FREETDS not set. Trying $HOME.
15:45:51.661862 34287 (config.c:293):Could not open '/var/lib/postgresql/.freetds.conf' ((.freetds.conf)).
15:45:51.661876 34287 (config.c:297):Found conf file '/etc/freetds/freetds.conf' (default).
15:45:51.661882 34287 (config.c:483):Looking for section global.
15:45:51.661911 34287 (config.c:540): Found section global.
15:45:51.661918 34287 (config.c:543):Got a match.
15:45:51.661925 34287 (config.c:565): dump file = '/tmp/freetds.log'
15:45:51.661931 34287 (config.c:565): debug flags = '0xffff'
15:45:51.661937 34287 (config.c:565): timeout = '30'
15:45:51.661943 34287 (config.c:565): connect timeout = '10'
15:45:51.661949 34287 (config.c:565): text size = '64512'
15:45:51.661955 34287 (config.c:540): Found section sybase.
15:45:51.661961 34287 (config.c:540): Found section egserver70.
15:45:51.661968 34287 (config.c:554): Reached EOF
15:45:51.661973 34287 (config.c:483):Looking for section 10.15.2.70:5000.
15:45:51.661980 34287 (config.c:540): Found section global.
15:45:51.661988 34287 (config.c:540): Found section sybase.
15:45:51.661994 34287 (config.c:540): Found section egserver70.
15:45:51.662000 34287 (config.c:554): Reached EOF
15:45:51.662004 34287 (config.c:303):[10.15.2.70:5000] not found.
15:45:51.662040 34287 (config.c:354):... $FREETDSCONF not set. Trying $FREETDS/etc.
15:45:51.662049 34287 (config.c:367):... $FREETDS not set. Trying $HOME.
15:45:51.662097 34287 (config.c:293):Could not open '/var/lib/postgresql/.freetds.conf' ((.freetds.conf)).
15:45:51.662120 34287 (config.c:297):Found conf file '/etc/freetds/freetds.conf' (default).
15:45:51.662132 34287 (config.c:483):Looking for section global.
15:45:51.662155 34287 (config.c:540): Found section global.
15:45:51.662168 34287 (config.c:543):Got a match.
15:45:51.662180 34287 (config.c:565): dump file = '/tmp/freetds.log'
15:45:51.662193 34287 (config.c:565): debug flags = '0xffff'
15:45:51.662206 34287 (config.c:565): timeout = '30'
15:45:51.662218 34287 (config.c:565): connect timeout = '10'
15:45:51.662229 34287 (config.c:565): text size = '64512'
15:45:51.662240 34287 (config.c:540): Found section sybase.
15:45:51.662253 34287 (config.c:540): Found section egserver70.
15:45:51.662267 34287 (config.c:554): Reached EOF
15:45:51.662278 34287 (config.c:483):Looking for section 10.15.2.70.
15:45:51.662292 34287 (config.c:540): Found section global.
15:45:51.662307 34287 (config.c:540): Found section sybase.
15:45:51.662319 34287 (config.c:540): Found section egserver70.
15:45:51.662329 34287 (config.c:554): Reached EOF
15:45:51.662337 34287 (config.c:303):[10.15.2.70] not found.
15:45:51.662364 34287 (iconv.c:330):tds_iconv_open(0x7f4ae5dd7d50, UTF-8)
15:45:51.662393 34287 (iconv.c:349):setting up conversions for client charset "UTF-8"
15:45:51.662398 34287 (iconv.c:351):preparing iconv for "UTF-8" <-> "UCS-2LE" conversion
15:45:51.662418 34287 (iconv.c:391):preparing iconv for "ISO-8859-1" <-> "ISO-8859-1" conversion
15:45:51.662425 34287 (iconv.c:394):tds_iconv_open: done
15:45:51.662432 34287 (net.c:205):Connecting to 10.15.2.70 port 5000 (TDS version 4.2)
15:45:51.662565 34287 (net.c:270):tds_open_socket: connect(2) returned "Operation now in progress"
15:45:51.781873 34287 (net.c:310):tds_open_socket() succeeded
15:45:51.781934 34287 (util.c:156):Changed query state from DEAD to IDLE
15:45:51.781993 34287 (net.c:741):Sending packet
0000 02 00 02 00 00 00 00 00-62 69 74 61 72 65 6e 61 |........ bitarena|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0020 00 00 00 00 00 00 08 73-61 00 00 00 00 00 00 00 |.......s a.......|
0030 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0040 00 00 00 00 00 02 6e 6f-74 31 63 6f 6d 6d 6f 6e |......no t1common|
0050 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0060 00 00 00 00 0a 33 34 32-38 37 00 00 00 00 00 00 |.....342 87......|
0070 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0080 00 00 00 05 03 01 06 0a-09 01 00 00 00 00 02 00 |........ ........|
0090 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00b0 00 00 00 31 30 2e 31 35-2e 32 2e 37 30 3a 35 30 |...10.15 .2.70:50|
00c0 30 30 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |00...... ........|
00d0 00 0f 6e 6f 74 31 63 6f-6d 6d 6f 6e 00 00 00 00 |..not1co mmon....|
00e0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
00f0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0100 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0110 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0120 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0130 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0140 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0150 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0160 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0170 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0180 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
0190 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01a0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01b0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01c0 00 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |........ ........|
01d0 00 0a 04 02 00 00 44 42-2d 4c 69 62 72 61 72 79 |......DB -Library|
01e0 0a 00 00 00 00 00 0d 11-75 73 5f 65 6e 67 6c 69 |........ us_engli|
01f0 73 68 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |sh...... ........|
15:45:51.782248 34287 (net.c:741):Sending packet
0000 02 01 00 4c 00 00 00 00-00 00 00 00 00 00 0a 00 |...L.... ........|
0010 00 00 00 00 00 00 00 00-00 00 00 00 00 75 74 66 |........ .....utf|
0020 38 00 00 00 00 00 00 00-00 00 00 00 00 00 00 00 |8....... ........|
0030 00 00 00 00 00 00 00 00-00 00 00 04 01 35 31 32 |........ .....512|
0040 00 00 00 03 00 00 00 00-00 00 00 00 |........ ....|
15:45:51.782395 34287 (token.c:328):tds_process_login_tokens()
15:45:51.912087 34287 (net.c:555):Received header
0000 04 01 00 70 00 00 00 00- |...p....|
15:45:51.912214 34287 (net.c:609):Received packet
0000 04 01 00 70 00 00 00 00-e3 0f 00 01 06 6d 61 73 |...p.... .....mas|
0010 74 65 72 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |ter.mast er.:.E..|
0020 00 02 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 6d 61 73 74 65 72-27 2e 0a 08 76 61 73 74 | 'master '...vast|
0050 67 5f 64 62 00 00 00 ad-0d 00 01 04 02 00 00 03 |g_db.... ........|
0060 41 53 45 0f 07 00 00 fd-00 00 02 00 5c 00 00 00 |ASE..... .......|
15:45:51.912284 34287 (token.c:337):looking for login token, got e3(ENVCHANGE)
15:45:51.912297 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:51.912315 34287 (dblib.c:327):db_env_chg(0x7f4ae5dd7d50, 1, master, master)
15:45:51.912329 34287 (token.c:337):looking for login token, got ab(INFO)
15:45:51.912339 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:51.912351 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:51.912367 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:51.912377 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5edcfd0, 0x7f4ae5dd7d50, 0x7ffffe5d9090)
15:45:51.912388 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'master'.
"
15:45:51.912839 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:51.912869 34287 (token.c:337):looking for login token, got ad(LOGINACK)
15:45:51.912881 34287 (token.c:373):server reports TDS version 4.2.0.0
15:45:51.912892 34287 (token.c:375):Product name for 0x4020000 is unknown
15:45:51.912905 34287 (token.c:337):looking for login token, got fd(DONE)
15:45:51.912916 34287 (token.c:122):tds_process_default_tokens() marker is fd(DONE)
15:45:51.912927 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:51.912938 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:51.912948 34287 (token.c:2370): rows_affected = 92
15:45:51.912958 34287 (token.c:438):tds_process_login_tokens() returning TDS_SUCCEED
15:45:51.913001 34287 (mem.c:615):tds_free_all_results()
15:45:51.913015 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:51.913027 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:51.913038 34287 (net.c:741):Sending packet
0000 01 01 00 1b 00 00 00 00-73 65 74 20 74 65 78 74 |........ set text|
0010 73 69 7a 65 20 36 34 35-31 32 20 |size 645 12 |
15:45:51.913302 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d91c8, 0x7ffffe5d91cc, 0x100)
15:45:51.913332 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.026788 34287 (net.c:555):Received header
0000 04 01 00 11 00 00 00 00- |........|
15:45:52.026862 34287 (net.c:609):Received packet
0000 04 01 00 11 00 00 00 00-fd 00 00 02 00 00 00 00 |........ ........|
0010 00 - |.|
15:45:52.026881 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:52.026894 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:52.026902 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:52.026910 34287 (util.c:156):Changed query state from READING to IDLE
15:45:52.026919 34287 (token.c:2370): rows_affected = 0
15:45:52.026927 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:52.026935 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d91c8, 0x7ffffe5d91cc, 0x100)
15:45:52.026944 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:52.026956 34287 (dblib.c:239):dblib_add_connection(0x7f4ad67d0760, 0x7f4ae5dd7d50)
15:45:52.027000 34287 (dblib.c:1398):dbuse(0x7f4ae5eccf70, sas_db)
15:45:52.027027 34287 (dblib.c:1312):dbcmd(0x7f4ae5eccf70, use [sas_db])
15:45:52.027041 34287 (dblib.c:1319):dbcmd() bufsz = 0
15:45:52.027052 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5eccf70)
15:45:52.027063 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5eccf70)
15:45:52.027074 34287 (mem.c:615):tds_free_all_results()
15:45:52.027085 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:52.027097 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:52.027107 34287 (net.c:741):Sending packet
0000 01 01 00 14 00 00 00 00-75 73 65 20 5b 73 61 73 |........ use [sas|
0010 5f 64 62 5d - |_db]|
15:45:52.027299 34287 (dblib.c:4639):dbsqlok(0x7f4ae5eccf70)
15:45:52.027327 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:52.027339 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d9628, 0x7ffffe5d962c, 0x6914)
15:45:52.027350 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.144390 34287 (net.c:555):Received header
0000 04 01 00 60 00 00 00 00- |...`....|
15:45:52.144481 34287 (net.c:609):Received packet
0000 04 01 00 60 00 00 00 00-e3 0f 00 01 06 73 61 73 |...`.... .....sas|
0010 5f 64 62 06 6d 61 73 74-65 72 ab 3a 00 45 16 00 |_db.mast er.:.E..|
0020 00 01 00 26 00 43 68 61-6e 67 65 64 20 64 61 74 |...&.Cha nged dat|
0030 61 62 61 73 65 20 63 6f-6e 74 65 78 74 20 74 6f |abase co ntext to|
0040 20 27 73 61 73 5f 64 62-27 2e 0a 08 76 61 73 74 | 'sas_db '...vast|
0050 67 5f 64 62 00 01 00 fd-00 00 02 00 00 00 00 00 |g_db.... ........|
15:45:52.144543 34287 (token.c:555):processing result tokens. marker is e3(ENVCHANGE)
15:45:52.144556 34287 (token.c:122):tds_process_default_tokens() marker is e3(ENVCHANGE)
15:45:52.144574 34287 (dblib.c:327):db_env_chg(0x7f4ae5dd7d50, 1, master, sas_db)
15:45:52.144590 34287 (token.c:555):processing result tokens. marker is ab(INFO)
15:45:52.144601 34287 (token.c:122):tds_process_default_tokens() marker is ab(INFO)
15:45:52.144612 34287 (token.c:2588):tds_process_msg() reading message 5701 from server
15:45:52.144626 34287 (token.c:2661):tds_process_msg() calling client msg handler
15:45:52.144637 34287 (dbutil.c:85):_dblib_handle_info_message(0x7f4ae5edcfd0, 0x7f4ae5dd7d50, 0x7ffffe5d9480)
15:45:52.144680 34287 (dbutil.c:86):msgno 5701: "Changed database context to 'sas_db'.
"
15:45:52.145166 34287 (token.c:2674):tds_process_msg() returning TDS_SUCCEED
15:45:52.145204 34287 (token.c:555):processing result tokens. marker is fd(DONE)
15:45:52.145228 34287 (token.c:2339):tds_process_end: more_results = 0
was_cancelled = 0
error = 0
done_count_valid = 0
15:45:52.145252 34287 (token.c:2355):tds_process_end() state set to TDS_IDLE
15:45:52.145273 34287 (util.c:156):Changed query state from READING to IDLE
15:45:52.145291 34287 (token.c:2370): rows_affected = 0
15:45:52.145309 34287 (util.c:104):logic error: cannot change query state from IDLE to PENDING
15:45:52.145321 34287 (dblib.c:4707):dbsqlok() end status is SUCCEED
15:45:52.145331 34287 (dblib.c:4718):dbsqlok() end status was success
15:45:52.145341 34287 (dblib.c:1668):dbresults(0x7f4ae5eccf70)
15:45:52.145352 34287 (dblib.c:1674):dbresults: dbresults_state is 5 (_DB_RES_SUCCEED)
15:45:52.145363 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:52.145373 34287 (dblib.c:5854):dbcanquery(0x7f4ae5eccf70)
15:45:52.145383 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d964c, (nil), 0x108)
15:45:52.145398 34287 (token.c:543):tds_process_tokens() state is COMPLETED
15:45:52.145516 34287 (dblib.c:1312):dbcmd(0x7f4ae5eccf70, select * from web_app.ApiSession)
15:45:52.145548 34287 (dblib.c:1319):dbcmd() bufsz = 13
15:45:52.145569 34287 (dblib.c:5882):dbfreebuf(0x7f4ae5eccf70)
15:45:52.145591 34287 (dblib.c:1369):dbsqlexec(0x7f4ae5eccf70)
15:45:52.145611 34287 (dblib.c:6862):dbsqlsend(0x7f4ae5eccf70)
15:45:52.145632 34287 (mem.c:615):tds_free_all_results()
15:45:52.145653 34287 (util.c:156):Changed query state from IDLE to QUERYING
15:45:52.145677 34287 (util.c:156):Changed query state from QUERYING to PENDING
15:45:52.145698 34287 (net.c:741):Sending packet
0000 01 01 00 28 00 00 00 00-73 65 6c 65 63 74 20 2a |...(.... select *|
0010 20 66 72 6f 6d 20 77 65-62 5f 61 70 70 2e 41 70 | from we b_app.Ap|
0020 69 53 65 73 73 69 6f 6e- |iSession|
15:45:52.146241 34287 (dblib.c:4639):dbsqlok(0x7f4ae5eccf70)
15:45:52.146325 34287 (dblib.c:4669):dbsqlok() not done, calling tds_process_tokens()
15:45:52.146359 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95b8, 0x7ffffe5d95bc, 0x6914)
15:45:52.146401 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.262567 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:52.262671 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-7c 73 0a 69 71 00 00 00 |........ |s.iq...|
0010 00 a0 96 00 0c 41 70 69-53 65 73 73 69 6f 6e 49 |.....Api SessionI|
0020 64 14 41 70 69 53 65 73-73 69 6f 6e 43 72 65 61 |d.ApiSes sionCrea|
0030 74 6f 72 55 49 44 14 41-64 6d 69 6e 69 73 74 72 |torUID.A dministr|
0040 61 74 6f 72 4c 6f 67 69-6e 49 64 10 4d 65 65 74 |atorLogi nId.Meet|
0050 69 6e 67 53 65 73 73 69-6f 6e 49 64 13 41 70 69 |ingSessi onId.Api|
0060 53 65 73 73 69 6f 6e 55-73 65 72 4e 6f 74 65 73 |SessionU serNotes|
0070 12 41 70 69 53 65 73 73-69 6f 6e 4d 6f 64 4e 6f |.ApiSess ionModNo|
0080 74 65 73 13 41 70 69 53-65 73 73 69 6f 6e 49 73 |tes.ApiS essionIs|
0090 44 65 6c 65 74 65 64 12-41 70 69 53 65 73 73 69 |Deleted. ApiSessi|
00a0 6f 6e 52 65 6d 6f 74 65-49 64 a1 60 00 2b 00 00 |onRemote Id.`.+..|
00b0 00 6d 08 23 00 00 00 e1-40 00 00 00 2b 00 00 00 |.m.#.... @...+...|
00c0 6d 08 2b 00 00 00 6d 08-14 00 00 00 22 00 fc 00 |m.+...m. ...."...|
00d0 00 12 00 77 65 62 5f 61-70 70 2e 41 70 69 53 65 |...web_a pp.ApiSe|
00e0 73 73 69 6f 6e 14 00 00-00 22 00 fc 00 00 12 00 |ssion... ."......|
00f0 77 65 62 5f 61 70 70 2e-41 70 69 53 65 73 73 69 |web_app. ApiSessi|
0100 6f 6e 10 00 00 00 32 2b-00 00 00 6d 08 ae 08 00 |on....2+ ...m....|
0110 00 00 00 00 00 00 00 00-d1 08 00 00 00 00 00 00 |........ ........|
0120 f0 3f 2a 00 00 00 62 00-72 00 75 00 63 00 65 00 |.?...b. r.u.c.e.|
0130 73 00 40 00 65 00 6c 00-6c 00 75 00 6d 00 69 00 |[email protected]. l.u.m.i.|
0140 6e 00 61 00 74 00 65 00-2e 00 63 00 6f 00 6d 00 |n.a.t.e. ..c.o.m.|
0150 08 00 00 00 00 28 cd 02-41 08 00 00 00 00 20 de |.....(.. A..... .|
0160 fd 40 10 5a 04 00 00 00-00 00 00 00 00 00 00 eb |[email protected].... ........|
0170 b0 4c 00 00 00 00 00 00-4c b0 eb 02 00 00 00 20 |.L...... L...... |
0180 00 10 5b 04 00 00 00 00-00 00 00 00 00 00 f2 b0 |..[..... ........|
0190 4c 00 00 00 00 00 00 4c-b0 f2 02 00 00 00 20 00 |L......L ...... .|
01a0 01 08 00 00 00 00 00 00-f0 3f d1 08 00 00 00 00 |........ .?......|
01b0 00 00 00 40 2a 00 00 00-62 00 72 00 75 00 63 00 |...@... b.r.u.c.|
01c0 65 00 73 00 40 00 65 00-6c 00 6c 00 75 00 6d 00 |[email protected]. l.l.u.m.|
01d0 69 00 6e 00 61 00 74 00-65 00 2e 00 63 00 6f 00 |i.n.a.t. e...c.o.|
01e0 6d 00 08 00 00 00 00 28-cd 02 41 08 00 00 00 00 |m......( ..A.....|
01f0 30 de fd 40 10 5c 04 00-00 00 00 00 00 00 00 00 |0..@... ........|
15:45:52.262963 34287 (token.c:555):processing result tokens. marker is 7c(PROCID)
15:45:52.262978 34287 (token.c:122):tds_process_default_tokens() marker is 7c(PROCID)
15:45:52.262990 34287 (token.c:555):processing result tokens. marker is a0(COLNAME)
15:45:52.263012 34287 (mem.c:615):tds_free_all_results()
15:45:52.263053 34287 (token.c:555):processing result tokens. marker is a1(COLFMT)
15:45:52.263069 34287 (token.c:1025):processing result. type = 109(float-null), varint_size 1
15:45:52.263082 34287 (token.c:1025):processing result. type = 35(text), varint_size 1
15:45:52.263148 34287 (token.c:3420):adjust_character_column_size:
Server charset: UTF-16LE
Server column_size: 64
Client charset: UTF-8
Client column_size: 128
15:45:52.263164 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263176 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263187 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263198 34287 (token.c:1025):processing result. type = 0(), varint_size 1
15:45:52.263208 34287 (token.c:1025):processing result. type = 98(variant), varint_size 1
15:45:52.263219 34287 (token.c:1025):processing result. type = 65(), varint_size 1
15:45:52.263230 34287 (token.c:1053):NOTE:tds_process_col_fmt: draining 48 bytes
15:45:52.263242 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.263255 34287 (dblib.c:4700):dbsqlok() found result token
15:45:52.263267 34287 (dblib.c:1668):dbresults(0x7f4ae5eccf70)
15:45:52.263278 34287 (dblib.c:1674):dbresults: dbresults_state is 1 (_DB_RES_RESULTSET_EMPTY)
15:45:52.263288 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95a8, 0x7ffffe5d95ac, 0x6914)
15:45:52.263299 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.263309 34287 (token.c:555):processing result tokens. marker is ae(CONTROL)
15:45:52.263319 34287 (token.c:122):tds_process_default_tokens() marker is ae(CONTROL)
15:45:52.263330 34287 (token.c:237):Eating CONTROL token
15:45:52.263340 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:52.263351 34287 (token.c:666):tds_process_tokens::SET_RETURN stopping on current token
15:45:52.263361 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.263371 34287 (dblib.c:1695):dbresults() tds_process_tokens returned 1 (TDS_SUCCEED),
result_type TDS_ROW_RESULT
15:45:52.263382 34287 (dblib.c:1657):dbresults returning 1 (SUCCEED)
15:45:52.263392 34287 (dblib.c:2018):dbnextrow(0x7f4ae5eccf70)
15:45:52.263402 34287 (dblib.c:2031):dbnextrow() dbresults_state = 2 (_DB_RES_RESULTSET_ROWS)
15:45:52.263412 34287 (token.c:540):tds_process_tokens(0x7f4ae5dd7d50, 0x7ffffe5d95bc, (nil), 0x1508)
15:45:52.263426 34287 (util.c:156):Changed query state from PENDING to READING
15:45:52.263435 34287 (token.c:555):processing result tokens. marker is d1(ROW)
15:45:52.263446 34287 (token.c:2304):tds_process_row(): reading column 0
15:45:52.263456 34287 (token.c:2049):tds_get_data: type 109, varint size 1
15:45:52.263466 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:52.263476 34287 (token.c:2304):tds_process_row(): reading column 1
15:45:52.263486 34287 (token.c:2049):tds_get_data: type 35, varint size 1
15:45:52.263510 34287 (token.c:2110):tds_get_data(): wire column size is 42
15:45:52.263528 34287 (token.c:2304):tds_process_row(): reading column 2
15:45:52.263539 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263549 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:52.263559 34287 (token.c:2304):tds_process_row(): reading column 3
15:45:52.263568 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263577 34287 (token.c:2110):tds_get_data(): wire column size is 109
15:45:52.263587 34287 (token.c:2304):tds_process_row(): reading column 4
15:45:52.263597 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.263606 34287 (token.c:2110):tds_get_data(): wire column size is 117
15:45:52.265020 34287 (net.c:555):Received header
0000 04 00 02 00 00 00 00 00- |........|
15:45:52.265047 34287 (net.c:609):Received packet
0000 04 00 02 00 00 00 00 00-00 fb b0 4c 00 00 00 00 |........ ...L....|
0010 00 00 4c b0 fb 02 00 00-00 20 00 10 5d 04 00 00 |..L..... . ..]...|
0020 00 00 00 00 00 00 00 00-02 b1 4c 00 00 00 00 00 |........ ..L.....|
0030 00 4c b1 02 02 00 00 00-20 00 00 08 00 00 00 00 |.L...... .......|
0040 00 00 00 40 d1 08 00 00-00 00 00 00 08 40 2a 00 |...@.... .....@.|
0050 00 00 62 00 72 00 75 00-63 00 65 00 73 00 40 00 |..b.r.u. c.e.s.@.|
0060 65 00 6c 00 6c 00 75 00-6d 00 69 00 6e 00 61 00 |e.l.l.u. m.i.n.a.|
0070 74 00 65 00 2e 00 63 00-6f 00 6d 00 08 00 00 00 |t.e...c. o.m.....|
0080 00 28 cd 02 41 08 00 00-00 00 40 de fd 40 10 5e |.(..A... ..@..@.^|
0090 04 00 00 00 00 00 00 00-00 00 00 0b b1 4c 00 00 |........ .....L..|
00a0 00 00 00 00 4c b1 0b 02-00 00 00 20 00 10 5f 04 |....L... ... ...|
00b0 00 00 00 00 00 00 00 00-00 00 12 b1 4c 00 00 00 |........ ....L...|
00c0 00 00 00 4c b1 12 02 00-00 00 20 00 00 08 00 00 |...L.... .. .....|
00d0 00 00 00 00 08 40 d1 08-00 00 00 00 00 00 10 40 |.....@.. .......@|
00e0 2a 00 00 00 62 00 72 00-75 00 63 00 65 00 73 00 |_...b.r. u.c.e.s.|
00f0 40 00 65 00 6c 00 6c 00-75 00 6d 00 69 00 6e 00 |@.e.l.l. u.m.i.n.|
0100 61 00 74 00 65 00 2e 00-63 00 6f 00 6d 00 08 00 |a.t.e... c.o.m...|
0110 00 00 00 28 cd 02 41 08-00 00 00 00 40 ab fe 40 |...(..A. ....@..@|
0120 10 80 01 23 00 00 00 00-00 00 00 00 00 1b b1 4c |...#.... .......L|
0130 00 00 00 00 00 00 4c b1-1b 02 00 00 00 20 00 10 |......L. ..... ..|
0140 81 01 23 00 00 00 00 00-00 00 00 00 23 b1 4c 00 |..#..... ....#.L.|
0150 00 00 00 00 00 4c b1 23-02 00 00 00 20 00 00 08 |.....L.# .... ...|
0160 00 00 00 00 00 00 10 40-d1 08 00 00 00 00 00 00 |.......@ ........|
0170 24 40 12 00 00 00 75 00-69 00 67 00 63 00 61 00 |[email protected]. i.g.c.a.|
0180 64 00 6d 00 69 00 6e 00-08 00 00 00 00 68 14 03 |d.m.i.n. .....h..|
0190 41 08 00 00 00 00 18 24-00 41 10 82 01 23 00 00 |A......$ .A...#..|
01a0 00 00 00 00 00 00 00 2b-b1 4c 00 00 00 00 00 00 |.......+ .L......|
01b0 4c b1 2b 02 00 00 00 20-00 10 83 01 23 00 00 00 |L.+.... ....#...|
01c0 00 00 00 00 00 00 32 b1-4c 00 00 00 00 00 00 4c |......2. L......L|
01d0 b1 32 02 00 00 00 20 00-00 08 00 00 00 00 00 00 |.2.... . ........|
01e0 24 40 d1 08 00 00 00 00-00 00 26 40 12 00 00 00 |$@...... ..&@....|
01f0 75 00 69 00 67 00 63 00-61 00 64 00 6d 00 69 00 |u.i.g.c. a.d.m.i.|
15:45:52.265173 34287 (token.c:2304):tds_process_row(): reading column 5
15:45:52.265180 34287 (token.c:2049):tds_get_data: type 0, varint size 1
15:45:52.265190 34287 (token.c:2110):tds_get_data(): wire column size is -1
15:45:52.265200 34287 (token.c:2304):tds_process_row(): reading column 6
15:45:52.265210 34287 (token.c:2049):tds_get_data: type 98, varint size 1
15:45:52.265220 34287 (token.c:2110):tds_get_data(): wire column size is 8
15:45:52.265231 34287 (token.c:2304):tds_process_row(): reading column 7
15:45:52.265241 34287 (token.c:2049):tds_get_data: type 65, varint size 1
15:45:52.265250 34287 (token.c:2110):tds_get_data(): wire column size is 209
15:45:52.265258 34287 (util.c:156):Changed query state from READING to PENDING
15:45:52.265268 34287 (buffering.h:306):buffer_transfer_bound_data(0x7f4ae5eccf80 4040 -1 0x7f4ae5eccf70 0)
15:45:52.265286 34287 (dblib.c:2100):leaving dbnextrow() returning REG_ROW/MORE_ROWS
15:45:52.265292 34287 (dblib.c:1813):dbnumcols(0x7f4ae5eccf70)
15:45:52.265305 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 1)
15:45:52.265317 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 1)
15:45:52.265322 34287 (dblib.c:3142):dbdatlen() type = 109, len= 8
15:45:52.265328 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 1)
15:45:52.265333 34287 (dblib.c:2812):dbwillconvert(SYBFLT8, SYBCHAR)
15:45:52.265340 34287 (convert.c:2788):tds_willconvert(62, 47)
15:45:52.265348 34287 (convert.c:2792):tds_willconvert(62, 47) returns yes
15:45:52.265356 34287 (dblib.c:2217):dbconvert(0x7f4ae5eccf70, SYBFLT8, 0x7f4ae5ef1020, 8, SYBCHAR, 0x7f4ae5f076a0, -1)
15:45:52.265361 34287 (dblib.c:2349):dbconvert() calling tds_convert
15:45:52.265383 34287 (dblib.c:2352):dbconvert() called tds_convert returned 1
15:45:52.265389 34287 (dblib.c:2455):dbconvert() outputting 1 bytes character data destlen = -1
15:45:52.265395 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 2)
15:45:52.265400 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 2)
15:45:52.265405 34287 (dblib.c:3142):dbdatlen() type = 35, len= 61
15:45:52.265409 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 2)
15:45:52.265414 34287 (dblib.c:2812):dbwillconvert(SYBTEXT, SYBCHAR)
15:45:52.265419 34287 (convert.c:2788):tds_willconvert(35, 47)
15:45:52.265424 34287 (convert.c:2792):tds_willconvert(35, 47) returns yes
15:45:52.265429 34287 (dblib.c:2217):dbconvert(0x7f4ae5eccf70, SYBTEXT, 0x7f4ae5ef1028, 61, SYBCHAR, 0x7f4ae5f07ab0, -1)
15:45:52.265434 34287 (dblib.c:2349):dbconvert() calling tds_convert
15:45:52.265442 34287 (dblib.c:2352):dbconvert() called tds_convert returned 61
15:45:52.265447 34287 (dblib.c:2455):dbconvert() outputting 61 bytes character data destlen = -1
15:45:52.265452 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 3)
15:45:52.265457 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 3)
15:45:52.265462 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265467 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 3)
15:45:52.265471 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 4)
15:45:52.265476 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 4)
15:45:52.265481 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265485 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 4)
15:45:52.265490 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 5)
15:45:52.265494 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 5)
15:45:52.265499 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265504 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 5)
15:45:52.265509 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 6)
15:45:52.265513 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 6)
15:45:52.265518 34287 (dblib.c:3142):dbdatlen() type = 0, len= 0
15:45:52.265522 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 6)
15:45:52.265527 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 7)
15:45:52.265532 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 7)
15:45:52.265536 34287 (dblib.c:3142):dbdatlen() type = 98, len= 8
15:45:52.265541 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 7)
15:45:52.265545 34287 (dblib.c:2812):dbwillconvert(SYBVARIANT, SYBCHAR)
15:45:52.265550 34287 (convert.c:2788):tds_willconvert(98, 47)
15:45:52.265555 34287 (dblib.c:2831):dbcoltype(0x7f4ae5eccf70, 8)
15:45:52.265560 34287 (dblib.c:3133):dbdatlen(0x7f4ae5eccf70, 8)
15:45:52.265565 34287 (dblib.c:3142):dbdatlen() type = 65, len= 112
15:45:52.265569 34287 (dblib.c:3162):dbdata(0x7f4ae5eccf70, 8)
15:45:52.265574 34287 (dblib.c:2812):dbwillconvert(SYBUINT2, SYBCHAR)
15:45:52.265579 34287 (convert.c:2788):tds_willconvert(65, 47)
postgres@bitarena:~$
I can connect with fisql to the remote sybase server and retrieve that record with no problem:
postgres@bitarena:~$ fisql -S sybase -Usa -Pnot1common -w800 -D sas_db
Msg 5701, Level 10, State 2:
Server 'vastg_db', Changed database context to 'master'.
Msg 5701, Level 10, State 1:
Server 'vastg_db', Line 1:
Changed database context to 'sas_db'.
1>>
2>> set rowcount 1
3>> select * from web_app.ApiSession order by ApiSessionId
4>> go
ApiSessionId ApiSessionCreatorUID AdministratorLoginId MeetingSessionId ApiSessionUserNotes ApiSessionModNotes ApiSessionIsDeleted ApiSessionRemoteId
1 [email protected] 154021 122338 2000 2000 1 1 a
Any ideas?
Thanks!
Jeff