stdout/stderr routing is now 'virtually' async

master
Chris Punches 2021-04-03 20:24:22 -04:00
parent 199d93a2b2
commit 3d421b1ca0
4 changed files with 121 additions and 440 deletions

View File

@ -294,59 +294,96 @@ int Sproc::execute(std::string shell, std::string environment_file, std::string
char stdout_buf[1000] = {0};
char stderr_buf[1000] = {0};
std::cout.flush();
std::cerr.flush();
bool set_break = false;
// read from fd until child completes
while (! set_break ) {
ssize_t stdout_count = read(child_stdout_pipe[READ_END], stdout_buf, sizeof(stdout_buf) - 1);
// will contain a set of file descriptors to monitor representing stdout and stderr of the child process
fd_set readfds;
// cycle through STDOUT
switch (stdout_count) {
// loop completion flags
bool set_stdout_break = false;
bool set_stderr_break = false;
// read from fd until child completes -- signaled by stdout_break and stderr_break flags
while ((! set_stderr_break ) or (! set_stdout_break)) {
// clear it out to make sure it's clean
FD_ZERO( & readfds );
// add child stdout and stderr pipes (read end)
FD_SET( child_stdout_pipe[READ_END], & readfds );
FD_SET( child_stderr_pipe[READ_END], & readfds );
int highest_fd = child_stderr_pipe[READ_END] > child_stdout_pipe[READ_END] ? child_stderr_pipe[READ_END] : child_stdout_pipe[READ_END];
if ( select( highest_fd + 1, &readfds, NULL, NULL, NULL ) >= 0 )
{ // can read any
if ( FD_ISSET( child_stdout_pipe[READ_END], &readfds ) )
{
// can read child stdout pipe
// so do so
// read and return the byte size of what was read
int stdout_count = read(child_stdout_pipe[READ_END], stdout_buf, sizeof(stdout_buf) - 1);
// switch on the count size to allow for error return handling
switch(stdout_count) {
case READ_PIPEOPEN_O_NONBLOCK:
if (errno == EINTR) {
if ( errno == EINTR ) {
continue;
} else {
perror("read");
perror("read stdout");
slog.log(E_FATAL, "PIPE ISSUE with STDOUT");
exit(1);
}
case READ_EOF:
set_break = true;
// signal that STDOUT is complete
set_stdout_break = true;
break;
default:
tee_out.write(stdout_buf, stdout_count);
tee_out.write( stdout_buf, stdout_count );
tee_out.flush();
memset(&stdout_buf[0], 0, sizeof(stdout_buf));
// END SWITCH
// clear the buffer to prevent artifacts from previous loop
memset( &stdout_buf[0], 0, sizeof( stdout_buf ) -1 );
}
}
if ( FD_ISSET( child_stderr_pipe[READ_END], & readfds ) ) {
// can read child stderr pipe
// so do so
set_break = false;
while(! set_break ) {
ssize_t stderr_count = read(child_stderr_pipe[READ_END], stderr_buf, sizeof(stderr_buf) - 1 );
switch ( stderr_count )
{
case READ_PIPEOPEN_O_NONBLOCK:
if (errno == EINTR) {
// read and return the byte size of what was read
int stderr_count = read( child_stderr_pipe[READ_END], stderr_buf, sizeof( stderr_buf ) -1 );
// switch on the count size to allow for error return handling
switch( stderr_count ) {
case READ_RESULTS::READ_PIPEOPEN_O_NONBLOCK:
if ( errno == EINTR ) {
continue;
} else {
perror("read");
slog.log( E_FATAL, "PIPE ISSUE with STDERR" );
perror( "read stderr" );
slog.log( E_FATAL, "PIPE ISSUE WITH STDERR" );
exit(1);
}
case READ_EOF:
set_break = true;
break;
case READ_RESULTS::READ_EOF:
set_stderr_break = true;
//break;
continue;
default:
tee_err.write( stderr_buf, stderr_count );
tee_err.flush();
memset(&stderr_buf[0], 0, sizeof(stderr_buf));
// END SWITCH
// clear the buffer to prevent artifacts from previous loop
memset( &stderr_buf[0], 0, sizeof( stderr_buf ) -1 );
}
}
} else {
// select error, fatal, throw
slog.log( E_FATAL, "Fatal error, Unknown.");
} // end select/if
}
while ((pid = waitpid(pid, &exit_code_raw, 0)) == -1) {}
//waitpid( pid, &exit_code_raw, 0 );
@ -356,6 +393,5 @@ int Sproc::execute(std::string shell, std::string environment_file, std::string
stderr_log.close();
}
}
return WEXITSTATUS( exit_code_raw );
}

View File

@ -3,7 +3,6 @@
{ "name": "independent test 1", "dependencies": [ null ] },
{ "name": "independent test 2", "dependencies": [ null ] },
{ "name": "dependent test", "dependencies": [ "independent test 1" ] },
{ "name": "curses dialog", "dependencies": [ null ] },
{ "name": "fail", "dependencies": [ null ] }
]
}

View File

@ -1,4 +1,2 @@
12131231321This test is printing to stderr.
1321321This test is printing to stderr.
8675309This test is printing to stderr.
This test is printing to stderr.

View File

@ -1,398 +1,46 @@
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
TEST OUTPUT: Test var is: 999
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
independent test 2 output
independent test says TEST_VAR is 999
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
dependent test
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'curses dialog' ] TEE Logging enabled.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] UID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] GID of 'bagira' is '1000'.
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:00:35] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:00:35] [INFO] [_sproc] [ 'curses dialog' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
[?1049h(B[?7h[?1h=[?1006;1000h[?1h=[?1h=(B(B

























 (0lqqqqqqq(BDialog title(0qqqqqqqqq(0k(B (0x(B Enter your name: (0x(B  (0x(B (0lqqqqqqqqqqqqqqqqqqqqqqqq(0k(B (0x(B  (0x(B (0x(B(0x(B (0x(B  (0x(B (0m(0qqqqqqqqqqqqqqqqqqqqqqqqj(B (0x(B  (0tqqqqqqqqqqqqqqqqqqqqqqqqqqqq(0u(B  (0x(B (B< OK >(B <C(Bancel(B> (0x(B  (0m(0qqqqqqqqqqqqqqqqqqqqqqqqqqqqj(B  (B(B1(B2(B1(B3(B[?1006;1000l[?1049l [?1l>test
[2021-03-25_02:00:38] [INFO] [_sproc] [ 'fail' ] TEE Logging enabled.
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] UID of 'bagira' is '1000'.
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] GID of 'bagira' is '1000'.
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:00:38] [DBUG] [_sproc] [ 'fail' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:00:38] [INFO] [_sproc] [ 'fail' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
This test will fail on purpose.
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
TEST OUTPUT: Test var is: 999
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
independent test 2 output
independent test says TEST_VAR is 999
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
dependent test
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'curses dialog' ] TEE Logging enabled.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] UID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] GID of 'bagira' is '1000'.
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:01:19] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:01:19] [INFO] [_sproc] [ 'curses dialog' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
[?1049h(B[?7h[?1h=[?1006;1000h[?1h=[?1h=(B(B

























 (0lqqqqqqq(BDialog title(0qqqqqqqqq(0k(B (0x(B Enter your name: (0x(B  (0x(B (0lqqqqqqqqqqqqqqqqqqqqqqqq(0k(B (0x(B  (0x(B (0x(B(0x(B (0x(B  (0x(B (0m(0qqqqqqqqqqqqqqqqqqqqqqqqj(B (0x(B  (0tqqqqqqqqqqqqqqqqqqqqqqqqqqqq(0u(B  (0x(B (B< OK >(B <C(Bancel(B> (0x(B  (0m(0qqqqqqqqqqqqqqqqqqqqqqqqqqqqj(B  (B(B1(B2(B1(B3(B[?1006;1000l[?1049l [?1l>test
[2021-03-25_02:01:21] [INFO] [_sproc] [ 'fail' ] TEE Logging enabled.
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] UID of 'bagira' is '1000'.
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] GID of 'bagira' is '1000'.
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:01:21] [DBUG] [_sproc] [ 'fail' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:01:21] [INFO] [_sproc] [ 'fail' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
This test will fail on purpose.
[2021-03-25_02:02:59] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:02:59] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:02:59] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
TEST OUTPUT: Test var is: 999
[2021-03-25_02:04:11] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:04:11] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:04:11] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
independent test 2 output
independent test says TEST_VAR is 999
[2021-03-25_02:04:35] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:04:35] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:04:35] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
dependent test
[2021-03-25_02:04:44] [INFO] [_sproc] [ 'curses dialog' ] TEE Logging enabled.
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] UID of 'bagira' is '1000'.
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] GID of 'bagira' is '1000'.
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:04:44] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:04:44] [INFO] [_sproc] [ 'curses dialog' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
test
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
TEST OUTPUT: Test var is: 999
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
independent test 2 output
independent test says TEST_VAR is 999
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
dependent test
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'curses dialog' ] TEE Logging enabled.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] UID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] GID of 'bagira' is '1000'.
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:07:20] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:07:20] [INFO] [_sproc] [ 'curses dialog' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
[?1049h(B[?7h[?1h=[?1006;1000h[?1h=[?1h=(B(B





 (0lqqqqqqq(BDialog title(0qqqqqqqqq(0k(B (0x(B Enter your name: (0x(B  (0x(B (0lqqqqqqqqqqqqqqqqqqqqqqqq(0k(B (0x(B  (0x(B (0x(B(0x(B (0x(B  (0x(B (0m(0qqqqqqqqqqqqqqqqqqqqqqqqj(B (0x(B  (0tqqqqqqqqqqqqqqqqqqqqqqqqqqqq(0u(B  (0x(B (B< OK >(B <C(Bancel(B> (0x(B  (0m(0qqqqqqqqqqqqqqqqqqqqqqqqqqqqj(B  (B(B1(B2(B3(B1(B3(B2(B1(B[?1006;1000l[?1049l [?1l>test
[2021-03-25_02:07:22] [INFO] [_sproc] [ 'fail' ] TEE Logging enabled.
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] UID of 'bagira' is '1000'.
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] GID of 'bagira' is '1000'.
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:07:22] [DBUG] [_sproc] [ 'fail' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:07:22] [INFO] [_sproc] [ 'fail' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
This test will fail on purpose.
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
TEST OUTPUT: Test var is: 999
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
independent test 2 output
independent test says TEST_VAR is 999
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
dependent test
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'curses dialog' ] TEE Logging enabled.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:01] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:01] [INFO] [_sproc] [ 'curses dialog' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
[?1049h(B[?7h[?1h=[?1006;1000h[?1h=[?1h=(B(B





 (0lqqqqqqq(BDialog title(0qqqqqqqqq(0k(B (0x(B Enter your name: (0x(B  (0x(B (0lqqqqqqqqqqqqqqqqqqqqqqqq(0k(B (0x(B  (0x(B (0x(B(0x(B (0x(B  (0x(B (0m(0qqqqqqqqqqqqqqqqqqqqqqqqj(B (0x(B  (0tqqqqqqqqqqqqqqqqqqqqqqqqqqqq(0u(B  (0x(B (B< OK >(B <C(Bancel(B> (0x(B  (0m(0qqqqqqqqqqqqqqqqqqqqqqqqqqqqj(B  (B(B1(B3(B2(B1(B3(B2(B1(B[?1006;1000l[?1049l [?1l>test
[2021-03-25_02:08:12] [INFO] [_sproc] [ 'fail' ] TEE Logging enabled.
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:12] [DBUG] [_sproc] [ 'fail' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:12] [INFO] [_sproc] [ 'fail' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
This test will fail on purpose.
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'independent test 1' ] TEE Logging enabled.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 1' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'independent test 1' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
TEST OUTPUT: Test var is: 999
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'independent test 2' ] TEE Logging enabled.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'independent test 2' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'independent test 2' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
independent test 2 output
independent test says TEST_VAR is 999
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'dependent test' ] TEE Logging enabled.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'dependent test' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'dependent test' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
dependent test
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'curses dialog' ] TEE Logging enabled.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:30] [DBUG] [_sproc] [ 'curses dialog' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:30] [INFO] [_sproc] [ 'curses dialog' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
[?1049h(B[?7h[?1h=[?1006;1000h[?1h=[?1h=(B(B





 (0lqqqqqqq(BDialog title(0qqqqqqqqq(0k(B (0x(B Enter your name: (0x(B  (0x(B (0lqqqqqqqqqqqqqqqqqqqqqqqq(0k(B (0x(B  (0x(B (0x(B(0x(B (0x(B  (0x(B (0m(0qqqqqqqqqqqqqqqqqqqqqqqqj(B (0x(B  (0tqqqqqqqqqqqqqqqqqqqqqqqqqqqq(0u(B  (0x(B (B< OK >(B <C(Bancel(B> (0x(B  (0m(0qqqqqqqqqqqqqqqqqqqqqqqqqqqqj(B  (B(B8(B6(B7(B5(B3(B0(B9(B[?1006;1000l[?1049l [?1l>test
[2021-03-25_02:08:38] [INFO] [_sproc] [ 'fail' ] TEE Logging enabled.
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as user 'bagira'.
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as group_name 'bagira'.
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] UID of 'bagira' is '1000'.
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] GID of 'bagira' is '1000'.
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] Successfully set GID to '1000' (bagira).
[2021-03-25_02:08:38] [DBUG] [_sproc] [ 'fail' ] Successfully set UID to '1000' (bagira).
[2021-03-25_02:08:38] [INFO] [_sproc] [ 'fail' ] Identity context set as user 'bagira' and group 'bagira'.
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'fail' ] TEE Logging enabled.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] DUP2: child_*_pipe[1]->STD*_FILENO
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as user 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] Attempt: Running as group_name 'bagira'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] UID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] GID of 'bagira' is '1000'.
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] Successfully set GID to '1000' (bagira).
[2021-04-03_20:20:26] [DBUG] [_sproc] [ 'fail' ] Successfully set UID to '1000' (bagira).
[2021-04-03_20:20:26] [INFO] [_sproc] [ 'fail' ] Identity context set as user 'bagira' and group 'bagira'.
variables file says hello and set a variable named TEST_VAR
This test will fail on purpose.