==> erloci (eunit)
Compiled src/oci_logger.erl
Compiled src/oci_util.erl
src/oci_port.erl:404: Warning: variable 'SessionId' is unused
Compiled src/oci_port.erl
Compiled src/erloci.erl
test/erloci_SUITE.erl:39: Warning: erlang:now/0: Deprecated BIF. See the "Time and Time Correction in Erlang" chapter of the ERTS User's Guide for more information.
Compiled test/erloci_SUITE.erl
test/erloci_test.erl:116: Warning: the call to make_ref/0 has no effect
test/erloci_test.erl:435: Warning: variable 'RowIDs' is unused
Compiled test/erloci_test.erl
37:39.251000 [debug] {oci_logger,,71} ---- ERLOCI PORT PROCESS LOGGER ----
37:39.260000 [debug] {oci_port,,312} PATH = ...
37:39.260000 [debug] {oci_port,,320} Extra Env :[{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]
37:39.260000 [debug] {oci_port,,330} Executable "d:/Temp/erloci/priv/ocierl.exe"
37:39.260000 [debug] {oci_port,,331} Options :[{packet,4},
          binary,exit_status,use_stdio,
          {args,["262144","true","51545"]},
          {env,[{"PATH",[]},{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]}]
37:39.260000 [debug] {oci_port,,342} started log enabled new port:
[{name,"d:/Temp/erloci/priv/ocierl.exe"},
 {links,[<0.255.0>]},
 {id,823},
 {connected,<0.255.0>},
 {input,0},
 {output,19},
 {os_pid,12144}]
37:39.260000 [debug] {oci_logger,,116} 37:39.260000 Waiting for peer to connect on 51545
37:39.773000 [debug] {oci_logger,,124} 37:39.773000 Connection from 51546 to 51545
37:39.773000 [info] {erloci.cpp,main,80} Port process configs : erlang term max size 0x00040000 bytes, logging enabled, TCP port for logs 51545, NLS_LANG GERMAN_SWITZERLAND.AL32UTF8
test/erloci_test.erl:104:<0.258.0>: 37:39.773000 +---------------------------------------------+
test/erloci_test.erl:105:<0.258.0>: 37:39.774000 |                     echo                    |
test/erloci_test.erl:106:<0.258.0>: 37:39.774000 +---------------------------------------------+
test/erloci_test.erl:107:<0.258.0>: 37:39.774000 echo back erlang terms
37:39.805000 [info] {ocisession.cpp,ocisession::config,69} OCI Initialized
37:39.806000 [info] {command.cpp,command::change_log_flag,54} Enabled logging...
37:39.806000 [info] {oci_port,,465} Remote log_enabled
37:39.806000 [debug] {oci_port,,398} no reply for log_enabled
test/erloci_test.erl:132:<0.258.0>: 37:40.576000 +---------------------------------------------+
test/erloci_test.erl:133:<0.258.0>: 37:40.576000 |                 bad_password                |
test/erloci_test.erl:134:<0.258.0>: 37:40.576000 +---------------------------------------------+
test/erloci_test.erl:135:<0.258.0>: 37:40.576000 get_session with wrong password
37:41.260000 [error] {ocisession.cpp,ocisession::ocisession,117} failed OCISessionGet ORA-01017: invalid username/password; logon denied


test/erloci_test.erl:142:<0.258.0>: 37:41.263000 +---------------------------------------------+
test/erloci_test.erl:143:<0.258.0>: 37:41.263000 |                 session_ping                |
test/erloci_test.erl:144:<0.258.0>: 37:41.263000 +---------------------------------------------+
test/erloci_test.erl:145:<0.258.0>: 37:41.263000 ping oci session
37:41.760000 [info] {ocisession.cpp,ocisession::ocisession,123} got session 0000000002BF5FF8 (DESCRIPTION=(ADDRESS_LIST=(ADDRESS=(PROTOCOL=tcp)(HOST=80.67.144.206)(PORT=5437)))(CONNECT_DATA=(SERVICE_NAME=XE))) user scott

37:41.760000 [info] {command.cpp,command::get_session,90} got connection 46047312


=INFO REPORT==== 21-Feb-2017::06:37:42 ===
    application: erloci
    exited: stopped
    type: temporary
37:42.250000 [debug] {oci_logger,,71} ---- ERLOCI PORT PROCESS LOGGER ----
37:42.252000 [debug] {oci_port,,312} PATH = ...
37:42.252000 [debug] {oci_port,,320} Extra Env :[{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]
37:42.252000 [debug] {oci_port,,330} Executable "d:/Temp/erloci/priv/ocierl.exe"
37:42.252000 [debug] {oci_port,,331} Options :[{packet,4},
          binary,exit_status,use_stdio,
          {args,["262144","true","51552"]},
          {env,[{"PATH",[]},{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]}]
37:42.252000 [debug] {oci_port,,342} started log enabled new port:
[{name,"d:/Temp/erloci/priv/ocierl.exe"},
 {links,[<0.269.0>]},
 {id,863},
 {connected,<0.269.0>},
 {input,0},
 {output,19},
 {os_pid,11628}]
37:42.252000 [debug] {oci_logger,,116} 37:42.252000 Waiting for peer to connect on 51552
37:42.255000 [debug] {oci_logger,,124} 37:42.255000 Connection from 51553 to 51552
37:42.255000 [info] {erloci.cpp,main,80} Port process configs : erlang term max size 0x00040000 bytes, logging enabled, TCP port for logs 51552, NLS_LANG GERMAN_SWITZERLAND.AL32UTF8
37:42.264000 [info] {ocisession.cpp,ocisession::config,69} OCI Initialized
37:42.264000 [info] {command.cpp,command::change_log_flag,54} Enabled logging...
37:42.264000 [info] {oci_port,,465} Remote log_enabled
37:42.264000 [debug] {oci_port,,398} no reply for log_enabled
37:42.831000 [info] {ocisession.cpp,ocisession::ocisession,123} got session 0000000002D8D3A8 (DESCRIPTION=(ADDRESS_LIST=(ADDRESS=(PROTOCOL=tcp)(HOST=80.67.144.206)(PORT=5437)))(CONNECT_DATA=(SERVICE_NAME=XE))) user scott

37:42.831000 [info] {command.cpp,command::get_session,90} got connection 18252688

test/erloci_test.erl:311:<0.273.0>: 37:42.831000 +---------------------------------------------+
test/erloci_test.erl:312:<0.273.0>: 37:42.831000 |                   drop_create               |
test/erloci_test.erl:313:<0.273.0>: 37:42.831000 +---------------------------------------------+
test/erloci_test.erl:315:<0.273.0>: 37:42.831000 creating (drop if exists) table erloci_test_1
37:43.025000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00942: table or view does not exist
 (drop table erloci_test_1)

test/erloci_test.erl:327:<0.273.0>: 37:43.296000 dropping table erloci_test_1
test/erloci_test.erl:334:<0.273.0>: 37:43.654000 +---------------------------------------------+
test/erloci_test.erl:335:<0.273.0>: 37:43.654000 |           bad_sql_connection_reuse          |
test/erloci_test.erl:336:<0.273.0>: 37:43.654000 +---------------------------------------------+
37:43.694000 [error] {ocistmt.cpp,ocistmt::ocistmt,133} failed OCIStmtPrepare2 ORA-01756: Anführungsstrich fehlt bei Zeichenfolge
 (select 'abc from dual)

test/erloci_test.erl:348:<0.273.0>: 37:43.999000 +---------------------------------------------+
test/erloci_test.erl:349:<0.273.0>: 37:43.999000 |            insert_select_update             |
test/erloci_test.erl:350:<0.273.0>: 37:43.999000 +---------------------------------------------+
test/erloci_test.erl:199:<0.273.0>: 37:43.999000 creating (drop if exists) table erloci_test_1
37:44.225000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00942: table or view does not exist
 (drop table erloci_test_1)

test/erloci_test.erl:208:<0.273.0>: 37:44.262000 creating table erloci_test_1
test/erloci_test.erl:355:<0.273.0>: 37:44.488000 insert into erloci_test_1 (pkey,publisher,rank,hero,reality,votes,createdate,  chapters,votes_first_rank) values (:pkey, :publisher, :rank, :hero, :reality, :votes, :createdate, :chapters, :votes_first_rank)
37:44.859000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:373:<0.273.0>: 37:44.859000 Bound insert statement reuse
37:45.101000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:390:<0.273.0>: 37:45.133000 select erloci_test_1.rowid, erloci_test_1.* from erloci_test_1
test/erloci_test.erl:394:<0.273.0>: 37:45.308000 selected columns [{<<"ROWID">>,'SQLT_RDD',19,0,0},
                               {<<"PKEY">>,'SQLT_NUM',22,38,0},
                               {<<"PUBLISHER">>,'SQLT_CHR',60,0,0},
                               {<<"RANK">>,'SQLT_NUM',22,126,-127},
                               {<<"HERO">>,'SQLT_IBDOUBLE',8,0,0},
                               {<<"REALITY">>,'SQLT_BIN',10,0,0},
                               {<<"VOTES">>,'SQLT_NUM',22,1,-10},
                               {<<"CREATEDATE">>,'SQLT_DAT',7,0,0},
                               {<<"CHAPTERS">>,'SQLT_IBFLOAT',4,0,0},
                               {<<"VOTES_FIRST_RANK">>,'SQLT_NUM',22,0,-127}] from table erloci_test_1
test/erloci_test.erl:437:<0.273.0>: 37:45.579000 RowIds [<<"AAAW9AAABAAALPRAAA">>,<<"AAAW9AAABAAALPRAAB">>,
                     <<"AAAW9AAABAAALPRAAC">>,<<"AAAW9AAABAAALPRAAD">>,
                     <<"AAAW9AAABAAALPRAAE">>,<<"AAAW9AAABAAALPRAAF">>]
test/erloci_test.erl:438:<0.273.0>: 37:45.579000 update erloci_test_1 set pkey = :pkey, publisher = :publisher, rank = :rank, hero = :hero, reality = :reality, votes = :votes, createdate = :createdate, chapters = :chapters, votes_first_rank = :votes_first_rank where erloci_test_1.rowid = :pri_rowid1
37:45.943000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:456:<0.273.0>: 37:45.943000 Bound update statement reuse
37:46.212000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:473:<0.273.0>: 37:46.232000 +---------------------------------------------+
test/erloci_test.erl:474:<0.273.0>: 37:46.232000 |              auto_rollback_test             |
test/erloci_test.erl:475:<0.273.0>: 37:46.232000 +---------------------------------------------+
test/erloci_test.erl:199:<0.273.0>: 37:46.232000 creating (drop if exists) table erloci_test_1
test/erloci_test.erl:208:<0.273.0>: 37:46.522000 creating table erloci_test_1
test/erloci_test.erl:480:<0.273.0>: 37:46.771000 inserting into table erloci_test_1
37:47.143000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:501:<0.273.0>: 37:47.170000 selecting from table erloci_test_1
test/erloci_test.erl:508:<0.273.0>: 37:47.457000 update in table erloci_test_1
37:47.697000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-01722: invalid number
 (update erloci_test_1 set pkey = :pkey, publisher = :publisher, rank = :rank, hero = :hero, reality = :reality, votes = :votes, createdate = :createdate, chapters = :chapters, votes_first_rank = :votes_first_rank where erloci_test_1.rowid = :pri_rowid1)

test/erloci_test.erl:531:<0.273.0>: 37:47.732000 testing rollback table erloci_test_1
test/erloci_test.erl:537:<0.273.0>: 37:47.888000 +---------------------------------------------+
test/erloci_test.erl:538:<0.273.0>: 37:47.888000 |            commit_rollback_test             |
test/erloci_test.erl:539:<0.273.0>: 37:47.888000 +---------------------------------------------+
test/erloci_test.erl:199:<0.273.0>: 37:47.888000 creating (drop if exists) table erloci_test_1
test/erloci_test.erl:208:<0.273.0>: 37:48.225000 creating table erloci_test_1
test/erloci_test.erl:544:<0.273.0>: 37:48.573000 inserting into table erloci_test_1
37:48.935000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:565:<0.273.0>: 37:48.973000 selecting from table erloci_test_1
test/erloci_test.erl:573:<0.273.0>: 37:49.256000 update in table erloci_test_1
test/erloci_test.erl:575:<0.273.0>: 37:49.257000 rowids [<<"AAAW9CAABAAALPRAAA">>,<<"AAAW9CAABAAALPRAAB">>,
                     <<"AAAW9CAABAAALPRAAC">>]
37:49.538000 [debug] {command.cpp,command::exec_stmt,525} Bounds 3
test/erloci_test.erl:598:<0.273.0>: 37:49.572000 testing rollback table erloci_test_1
test/erloci_test.erl:606:<0.273.0>: 37:49.873000 +---------------------------------------------+
test/erloci_test.erl:607:<0.273.0>: 37:49.873000 |                asc_desc_test                |
test/erloci_test.erl:608:<0.273.0>: 37:49.873000 +---------------------------------------------+
test/erloci_test.erl:199:<0.273.0>: 37:49.873000 creating (drop if exists) table erloci_test_1
test/erloci_test.erl:208:<0.273.0>: 37:50.269000 creating table erloci_test_1
test/erloci_test.erl:613:<0.273.0>: 37:50.519000 inserting into table erloci_test_1
37:51.311000 [debug] {command.cpp,command::exec_stmt,525} Bounds 10
test/erloci_test.erl:632:<0.273.0>: 37:51.360000 selecting from table erloci_test_1
test/erloci_test.erl:651:<0.273.0>: 37:52.403000 Got rows asc [[<<"AAAW9DAABAAALPRAAJ">>],
                           [<<"AAAW9DAABAAALPRAAI">>],
                           [<<"AAAW9DAABAAALPRAAH">>],
                           [<<"AAAW9DAABAAALPRAAG">>],
                           [<<"AAAW9DAABAAALPRAAF">>],
                           [<<"AAAW9DAABAAALPRAAE">>],
                           [<<"AAAW9DAABAAALPRAAD">>],
                           [<<"AAAW9DAABAAALPRAAC">>],
                           [<<"AAAW9DAABAAALPRAAB">>],
                           [<<"AAAW9DAABAAALPRAAA">>]]
 desc [[<<"AAAW9DAABAAALPRAAA">>],
       [<<"AAAW9DAABAAALPRAAB">>],
       [<<"AAAW9DAABAAALPRAAC">>],
       [<<"AAAW9DAABAAALPRAAD">>],
       [<<"AAAW9DAABAAALPRAAE">>],
       [<<"AAAW9DAABAAALPRAAF">>],
       [<<"AAAW9DAABAAALPRAAG">>],
       [<<"AAAW9DAABAAALPRAAH">>],
       [<<"AAAW9DAABAAALPRAAI">>],
       [<<"AAAW9DAABAAALPRAAJ">>]]
test/erloci_test.erl:215:<0.273.0>: 37:52.513000 +---------------------------------------------+
test/erloci_test.erl:216:<0.273.0>: 37:52.513000 |                   lob_test                  |
test/erloci_test.erl:217:<0.273.0>: 37:52.513000 +---------------------------------------------+
37:52.744000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-01031: insufficient privileges
 (create directory "TestDir" as 'd:/Temp/erloci/.eunit')

test/erloci_test.erl:239:<0.273.0>: 37:52.779000 Dir alias d:/Temp/erloci/.eunit creation failed 1031:ORA-01031: insufficient privileges

test/erloci_test.erl:659:<0.273.0>: 37:52.795000 +---------------------------------------------+
erloci_test: db_test_...test/erloci_test.erl:660:<0.273.0>: 37:52.795000 |               describe_test                 |
test/erloci_test.erl:661:<0.273.0>: 37:52.795000 +---------------------------------------------+
*failed*
in function erloci_test:'-lob_test/1-fun-8-'/1 (test/erloci_test.erl, line 240)
in call from erloci_test:lob_test/1 (test/erloci_test.erl, line 240)
**error:{assertEqual,[{module,erloci_test},
              {line,240},
              {expression,"\"Directory creation failed\""},
              {expected,"Directory Created"},
              {value,"Directory creation failed"}]}
test/erloci_test.erl:199:<0.273.0>: 37:52.795000 creating (drop if exists) table erloci_test_1
  output:<<"">>

test/erloci_test.erl:208:<0.273.0>: 37:53.053000 creating table erloci_test_1
test/erloci_test.erl:665:<0.273.0>: 37:53.349000 describing table erloci_test_1
test/erloci_test.erl:668:<0.273.0>: 37:53.470000 table erloci_test_1 has [{<<"PKEY">>,'SQLT_NUM',22},
                                      {<<"PUBLISHER">>,'SQLT_CHR',30},
                                      {<<"RANK">>,'SQLT_NUM',22},
                                      {<<"HERO">>,'SQLT_IBDOUBLE',8},
                                      {<<"REALITY">>,'SQLT_BIN',10},
                                      {<<"VOTES">>,'SQLT_NUM',22},
                                      {<<"CREATEDATE">>,'SQLT_DAT',7},
                                      {<<"CHAPTERS">>,'SQLT_IBFLOAT',4},
                                      {<<"VOTES_FIRST_RANK">>,'SQLT_NUM',22}]
test/erloci_test.erl:671:<0.273.0>: 37:53.483000 +---------------------------------------------+
test/erloci_test.erl:672:<0.273.0>: 37:53.483000 |              function_test                  |
test/erloci_test.erl:673:<0.273.0>: 37:53.483000 +---------------------------------------------+
37:54.187000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
test/erloci_test.erl:702:<0.273.0>: 37:54.235000 Col {<<"ERLOCI_TEST_FUNCTION(10,30)">>,'SQLT_NUM',22,0,0}
test/erloci_test.erl:711:<0.273.0>: 37:54.561000 +---------------------------------------------+
test/erloci_test.erl:712:<0.273.0>: 37:54.561000 |           procedure_scalar_test             |
test/erloci_test.erl:713:<0.273.0>: 37:54.561000 +---------------------------------------------+
37:55.061000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
37:55.180000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
37:55.499000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
37:55.666000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
37:55.976000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
37:56.136000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
test/erloci_test.erl:768:<0.273.0>: 37:56.497000 +---------------------------------------------+
test/erloci_test.erl:769:<0.273.0>: 37:56.497000 |             procedure_cur_test              |
test/erloci_test.erl:770:<0.273.0>: 37:56.497000 +---------------------------------------------+
test/erloci_test.erl:199:<0.273.0>: 37:56.497000 creating (drop if exists) table erloci_test_1
test/erloci_test.erl:208:<0.273.0>: 37:56.791000 creating table erloci_test_1
test/erloci_test.erl:776:<0.273.0>: 37:57.088000 inserting into table erloci_test_1
37:57.903000 [debug] {command.cpp,command::exec_stmt,525} Bounds 10
test/erloci_test.erl:824:<0.273.0>: 37:59.482000 +---------------------------------------------+
test/erloci_test.erl:825:<0.273.0>: 37:59.482000 |       timestamp_interval_datatypes          |
test/erloci_test.erl:826:<0.273.0>: 37:59.482000 +---------------------------------------------+
38:00.462000 [debug] {command.cpp,command::exec_stmt,525} Bounds 4
38:01.261000 [debug] {command.cpp,command::exec_stmt,525} Bounds 4
test/erloci_test.erl:915:<0.273.0>: 38:01.576000 +---------------------------------------------+
test/erloci_test.erl:916:<0.273.0>: 38:01.576000 |             stmt_reuse_onerror              |
test/erloci_test.erl:917:<0.273.0>: 38:01.576000 +---------------------------------------------+
38:01.774000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00942: table or view does not exist
 (drop table erloci_test_1)

38:02.496000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:02.626000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00001: unique constraint (SCOTT.SYS_C0013405) violated
 (insert into erloci_test_1 (unique_num) values (:unique_num))

38:02.866000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:02.978000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00001: unique constraint (SCOTT.SYS_C0013405) violated
 (insert into erloci_test_1 (unique_num) values (:unique_num))

test/erloci_test.erl:947:<0.273.0>: 38:03.435000 +---------------------------------------------+
test/erloci_test.erl:948:<0.273.0>: 38:03.435000 |             multiple_bind_reuse             |
test/erloci_test.erl:949:<0.273.0>: 38:03.435000 +---------------------------------------------+
38:03.602000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00942: table or view does not exist
 (drop table erloci_test_1)

38:04.195000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:04.303000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:04.420000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:04.554000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:04.671000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:04.799000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:04.895000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:05.022000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:05.146000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
38:05.262000 [debug] {command.cpp,command::exec_stmt,525} Bounds 1
test/erloci_test.erl:1017:<0.273.0>: 38:06.216000 +---------------------------------------------+
test/erloci_test.erl:1018:<0.273.0>: 38:06.216000 |                 check_ping                  |
test/erloci_test.erl:1019:<0.273.0>: 38:06.216000 +---------------------------------------------+
38:06.453000 [debug] {oci_logger,,71} ---- ERLOCI PORT PROCESS LOGGER ----
38:06.457000 [debug] {oci_port,,312} PATH = ...
38:06.457000 [debug] {oci_port,,320} Extra Env :[{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]
38:06.457000 [debug] {oci_port,,330} Executable "d:/Temp/erloci/priv/ocierl.exe"
38:06.457000 [debug] {oci_port,,331} Options :[{packet,4},
          binary,exit_status,use_stdio,
          {args,["262144","true","51563"]},
          {env,[{"PATH",[]},{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]}]
38:06.457000 [debug] {oci_port,,342} started log enabled new port:
[{name,"d:/Temp/erloci/priv/ocierl.exe"},
 {links,[<0.289.0>]},
 {id,1271},
 {connected,<0.289.0>},
 {input,0},
 {output,19},
 {os_pid,11772}]
38:06.457000 [debug] {oci_logger,,116} 38:06.457000 Waiting for peer to connect on 51563
38:06.461000 [debug] {oci_logger,,124} 38:06.461000 Connection from 51564 to 51563
38:06.461000 [info] {erloci.cpp,main,80} Port process configs : erlang term max size 0x00040000 bytes, logging enabled, TCP port for logs 51563, NLS_LANG GERMAN_SWITZERLAND.AL32UTF8
38:06.478000 [info] {ocisession.cpp,ocisession::config,69} OCI Initialized
38:06.478000 [info] {command.cpp,command::change_log_flag,54} Enabled logging...
38:06.479000 [info] {oci_port,,465} Remote log_enabled
38:06.479000 [debug] {oci_port,,398} no reply for log_enabled
38:07.082000 [info] {ocisession.cpp,ocisession::ocisession,123} got session 0000000002DAD3A8 (DESCRIPTION=(ADDRESS_LIST=(ADDRESS=(PROTOCOL=tcp)(HOST=80.67.144.206)(PORT=5437)))(CONNECT_DATA=(SERVICE_NAME=XE))) user scott

38:07.083000 [info] {command.cpp,command::get_session,90} got connection 17597328

test/erloci_test.erl:1079:<0.273.0>: 38:07.736000 <<"137,19463">> closed
38:08.201000 [error] {ocisession.cpp,ocisession::ping,134} failed OCIPing [ocisession::ping:132] Unable to extract detailed diagnostic information


test/erloci_test.erl:1034:<0.273.0>: 38:09.764000 +---------------------------------------------+
test/erloci_test.erl:1035:<0.273.0>: 38:09.764000 |         check_session_without_ping          |
test/erloci_test.erl:1036:<0.273.0>: 38:09.764000 +---------------------------------------------+
38:09.956000 [debug] {oci_logger,,71} ---- ERLOCI PORT PROCESS LOGGER ----
38:09.963000 [debug] {oci_port,,312} PATH = ...
38:09.964000 [debug] {oci_port,,320} Extra Env :[{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]
38:09.964000 [debug] {oci_port,,330} Executable "d:/Temp/erloci/priv/ocierl.exe"
38:09.964000 [debug] {oci_port,,331} Options :[{packet,4},
          binary,exit_status,use_stdio,
          {args,["262144","true","51568"]},
          {env,[{"PATH",[]},{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]}]
38:09.964000 [debug] {oci_port,,342} started log enabled new port:
[{name,"d:/Temp/erloci/priv/ocierl.exe"},
 {links,[<0.294.0>]},
 {id,1639},
 {connected,<0.294.0>},
 {input,0},
 {output,19},
 {os_pid,9668}]
38:09.965000 [debug] {oci_logger,,116} 38:09.965000 Waiting for peer to connect on 51568
38:09.975000 [debug] {oci_logger,,124} 38:09.975000 Connection from 51569 to 51568
38:09.975000 [info] {erloci.cpp,main,80} Port process configs : erlang term max size 0x00040000 bytes, logging enabled, TCP port for logs 51568, NLS_LANG GERMAN_SWITZERLAND.AL32UTF8
38:10.008000 [info] {ocisession.cpp,ocisession::config,69} OCI Initialized
38:10.009000 [info] {command.cpp,command::change_log_flag,54} Enabled logging...
38:10.009000 [info] {oci_port,,465} Remote log_enabled
38:10.009000 [debug] {oci_port,,398} no reply for log_enabled
38:10.510000 [info] {ocisession.cpp,ocisession::ocisession,123} got session 00000000034C25C8 (DESCRIPTION=(ADDRESS_LIST=(ADDRESS=(PROTOCOL=tcp)(HOST=80.67.144.206)(PORT=5437)))(CONNECT_DATA=(SERVICE_NAME=XE))) user scott

38:10.510000 [info] {command.cpp,command::get_session,90} got connection 25394672

test/erloci_test.erl:1079:<0.273.0>: 38:11.095000 <<"137,19465">> closed
38:11.190000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-03113: Unerwartetes Übertragungsende in Kommunikation
Prozess-ID: 19978
Session-ID: 137 Seriennummer: 19465
 (select 4+4 from dual)

test/erloci_test.erl:1050:<0.273.0>: 38:11.200000 +---------------------------------------------+
test/erloci_test.erl:1051:<0.273.0>: 38:11.200000 |           check_session_with_ping           |
test/erloci_test.erl:1052:<0.273.0>: 38:11.200000 +---------------------------------------------+
38:11.395000 [debug] {oci_logger,,71} ---- ERLOCI PORT PROCESS LOGGER ----
38:11.400000 [debug] {oci_port,,312} PATH = ...
38:11.400000 [debug] {oci_port,,320} Extra Env :[{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]
38:11.401000 [debug] {oci_port,,330} Executable "d:/Temp/erloci/priv/ocierl.exe"
38:11.401000 [debug] {oci_port,,331} Options :[{packet,4},
          binary,exit_status,use_stdio,
          {args,["262144","true","51571"]},
          {env,[{"PATH",[]},{"NLS_LANG","GERMAN_SWITZERLAND.AL32UTF8"}]}]
38:11.401000 [debug] {oci_port,,342} started log enabled new port:
[{name,"d:/Temp/erloci/priv/ocierl.exe"},
 {links,[<0.298.0>]},
 {id,1671},
 {connected,<0.298.0>},
 {input,0},
 {output,19},
 {os_pid,12208}]
38:11.401000 [debug] {oci_logger,,116} 38:11.401000 Waiting for peer to connect on 51571
38:11.409000 [debug] {oci_logger,,124} 38:11.409000 Connection from 51572 to 51571
38:11.409000 [info] {erloci.cpp,main,80} Port process configs : erlang term max size 0x00040000 bytes, logging enabled, TCP port for logs 51571, NLS_LANG GERMAN_SWITZERLAND.AL32UTF8
38:11.429000 [info] {ocisession.cpp,ocisession::config,69} OCI Initialized
38:11.429000 [info] {command.cpp,command::change_log_flag,54} Enabled logging...
38:11.430000 [info] {oci_port,,465} Remote log_enabled
38:11.430000 [debug] {oci_port,,398} no reply for log_enabled
38:12.004000 [info] {ocisession.cpp,ocisession::ocisession,123} got session 0000000002DCD3A8 (DESCRIPTION=(ADDRESS_LIST=(ADDRESS=(PROTOCOL=tcp)(HOST=80.67.144.206)(PORT=5437)))(CONNECT_DATA=(SERVICE_NAME=XE))) user scott

38:12.005000 [info] {command.cpp,command::get_session,90} got connection 18644464

test/erloci_test.erl:1079:<0.273.0>: 38:12.536000 <<"137,19467">> closed
38:15.330000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-03114: Nicht mit ORACLE verbunden
 (select 4+4 from dual)

erloci_test: db_test_...*failed*
in function erloci_test:'-check_session_with_ping/1-fun-9-'/1 (test/erloci_test.erl, line 1065)
**error:{assertMatch,[{module,erloci_test},
              {line,1065},
              {expression,"catch SelStmt1 : exec_stmt ( )"},
              {pattern,"{ 'EXIT' , { noproc , _ } }"},
              {value,{error,{3114,<<"ORA-03114: Nicht mit ORA"...>>}}}]}
  output:<<"">>

{oci_logger,108} TCP closed
{oci_logger,137} Terminating normal
38:15.481000 [error] {ocistmt.cpp,ocistmt::execute,277} failed OCIStmtExecute error ORA-00942: table or view does not exist
 (drop table erloci_test_1)


=INFO REPORT==== 21-Feb-2017::06:38:15 ===
    application: erloci
    exited: stopped
    type: temporary
=======================================================
  Failed: 2.  Skipped: 0.  Passed: 58.
Cover analysis: d:/Temp/erloci/.eunit/index.html