..\smpd_get_full_path_name
...fixing up exe name: 'cpi' -> '(null)'
../smpd_get_full_path_name
..handling executable:
cpi
..Processing environment variables 
..Processing drive mappings
..Creating launch nodes (2)
..\smpd_get_next_host
...\smpd_get_next_hostname
.../smpd_get_next_hostname
...\smpd_get_host_id
.../smpd_get_host_id
../smpd_get_next_host
..Adding host (AsusNetbook) to launch list 
..\smpd_get_next_host
...\smpd_get_next_hostname
.../smpd_get_next_hostname
...\smpd_get_host_id
.../smpd_get_host_id
../smpd_get_next_host
..Adding host (AsusNetbook) to launch list 
..\smpd_create_cliques
...\prev_launch_node
.../prev_launch_node
...\prev_launch_node
.../prev_launch_node
...\prev_launch_node
.../prev_launch_node
...\prev_launch_node
.../prev_launch_node
../smpd_create_cliques
..\smpd_fix_up_host_tree
../smpd_fix_up_host_tree
./mp_parse_command_args
.host tree:
. host: AsusNetbook, parent: 0, id: 1
.launch nodes:
. iproc: 1, id: 1, exe: cpi
. iproc: 0, id: 1, exe: cpi
.\SMPDU_Sock_create_set
..\smpd_get_smpd_data
...\smpd_get_smpd_data_from_environment
.../smpd_get_smpd_data_from_environment
../smpd_get_smpd_data
..\smpd_create_context
...\smpd_init_context
....\smpd_init_command
..../smpd_init_command
.../smpd_init_context
../smpd_create_context
..\SMPDU_Sock_post_connect
../SMPDU_Sock_post_connect
..\SMPDU_Sock_set_user_ptr
../SMPDU_Sock_set_user_ptr
..\smpd_make_socket_loop
...\smpd_get_hostname
.../smpd_get_hostname
../smpd_make_socket_loop
..\SMPDU_Sock_native_to_sock
../SMPDU_Sock_native_to_sock
..\SMPDU_Sock_native_to_sock
../SMPDU_Sock_native_to_sock
..\smpd_create_context
...\smpd_init_context
....\smpd_init_command
..../smpd_init_command
....\SMPDU_Sock_set_user_ptr
..../SMPDU_Sock_set_user_ptr
.../smpd_init_context
../smpd_create_context
..\SMPDU_Sock_post_read
...\SMPDU_Sock_post_readv
.../SMPDU_Sock_post_readv
../SMPDU_Sock_post_read
..\smpd_enter_at_state
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_CONNECT event.error = 0, result = 0, context=left
...\smpd_handle_op_connect
....connect succeeded, posting read of the challenge string
....\SMPDU_Sock_post_read
.....\SMPDU_Sock_post_readv
...../SMPDU_Sock_post_readv
..../SMPDU_Sock_post_read
.../smpd_handle_op_connect
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_challenge_string
.....read challenge string: '1.3a1 10762'
.....\smpd_verify_version
...../smpd_verify_version
.....Verification of smpd version succeeded
.....\smpd_hash
...../smpd_hash
.....\SMPDU_Sock_post_write
......\SMPDU_Sock_post_writev
....../SMPDU_Sock_post_writev
...../SMPDU_Sock_post_write
..../smpd_state_reading_challenge_string
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_challenge_response
.....wrote challenge response: '770555af36abea704df8e9dbd922b0bf'
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_writing_challenge_response
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_connect_result
.....read connect result: 'SUCCESS'
.....\SMPDU_Sock_post_write
......\SMPDU_Sock_post_writev
....../SMPDU_Sock_post_writev
...../SMPDU_Sock_post_write
..../smpd_state_reading_connect_result
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_process_session_request
.....wrote process session request: 'process'
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_writing_process_session_request
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cred_request
.....read cred request: 'nocredentials'
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cred_request
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_reconnect_request
.....read re-connect request: '3626'
.....closing the old socket in the left context.
.....\SMPDU_Sock_get_sock_id
...../SMPDU_Sock_get_sock_id
.....SMPDU_Sock_post_close(1608)
.....\SMPDU_Sock_post_close
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../SMPDU_Sock_post_close
.....connecting a new socket.
.....\smpd_create_context
......\smpd_init_context
.......\smpd_init_command
......./smpd_init_command
....../smpd_init_context
...../smpd_create_context
.....posting a re-connect to AsusNetbook:3626 in left context.
.....\SMPDU_Sock_post_connect
...../SMPDU_Sock_post_connect
..../smpd_state_reading_reconnect_request
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_CLOSE event.error = 0, result = 0, context=left
...\smpd_handle_op_close
....\smpd_get_state_string
..../smpd_get_state_string
....op_close received - SMPD_CLOSING state.
....Unaffiliated left context closing.
....\smpd_free_context
.....freeing left context.
.....\smpd_init_context
......\smpd_init_command
....../smpd_init_command
...../smpd_init_context
..../smpd_free_context
.../smpd_handle_op_close
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_CONNECT event.error = 0, result = 0, context=left
...\smpd_handle_op_connect
....\smpd_generate_session_header
.....session header: (id=1 parent=0 level=0)
..../smpd_generate_session_header
....\SMPDU_Sock_post_write
.....\SMPDU_Sock_post_writev
...../SMPDU_Sock_post_writev
..../SMPDU_Sock_post_write
.../smpd_handle_op_connect
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_session_header
.....wrote session header: 'id=1 parent=0 level=0'
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
.....\smpd_create_command
......\smpd_init_command
....../smpd_init_command
...../smpd_create_command
.....\smpd_post_write_command
......\smpd_package_command
....../smpd_package_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......smpd_post_write_command on the left context sock 1552: 47 bytes for command: "cmd=start_dbs src=0 dest=1 tag=0 "
......\SMPDU_Sock_post_writev
....../SMPDU_Sock_post_writev
...../smpd_post_write_command
..../smpd_state_writing_session_header
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=start_dbs src=0 dest=1 tag=0 "
.....moving 'start_dbs' command to the wait_list.
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 170 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=result src=1 dest=0 tag=0 cmd_tag=0 cmd_orig=start_dbs kvs_name=F2E6A159-5401-4b19-8966-5CC999BFAE91 domain_name=81CDE767-7418-44b6-8DDC-C30D4216EB2B result=SUCCESS "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = result
...... tag  = 0
...... ctx  = left
...... len  = 170
...... str  = cmd=result src=1 dest=0 tag=0 cmd_tag=0 cmd_orig=start_dbs kvs_name=F2E6A159-5401-4b19-8966-5CC999BFAE91 domain_name=81CDE767-7418-44b6-8DDC-C30D4216EB2B result=SUCCESS 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_result
.......start_dbs succeeded, kvs_name: 'F2E6A159-5401-4b19-8966-5CC999BFAE91', domain_name: '81CDE767-7418-44b6-8DDC-C30D4216EB2B'
.......\smpd_launch_processes
........creating a process group of size 2 on node 0 called F2E6A159-5401-4b19-8966-5CC999BFAE91
........\create_process_group
......../create_process_group
........launching the processes.
........\smpd_create_command
.........\smpd_init_command
........./smpd_init_command
......../smpd_create_command
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_post_write_command
.........\smpd_package_command
........./smpd_package_command
.........\SMPDU_Sock_get_sock_id
........./SMPDU_Sock_get_sock_id
.........smpd_post_write_command on the left context sock 1552: 216 bytes for command: "cmd=launch src=0 dest=1 tag=1 c=cpi s=0 a=0 d="C:\Program Files\MPICH2\bin" p="C:\Program Files\MPICH2\bin" q=0..1 i=1 n=2 k=F2E6A159-5401-4b19-8966-5CC999BFAE91 kd=81CDE767-7418-44b6-8DDC-C30D4216EB2B "
.........\SMPDU_Sock_post_writev
........./SMPDU_Sock_post_writev
......../smpd_post_write_command
........\smpd_create_command
.........\smpd_init_command
........./smpd_init_command
......../smpd_create_command
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_post_write_command
.........\smpd_package_command
........./smpd_package_command
.........enqueueing write at the end of the list.
......../smpd_post_write_command
......./smpd_launch_processes
.......\smpd_free_command
........\smpd_init_command
......../smpd_init_command
......./smpd_free_command
....../smpd_handle_result
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=launch src=0 dest=1 tag=1 c=cpi s=0 a=0 d="C:\Program Files\MPICH2\bin" p="C:\Program Files\MPICH2\bin" q=0..1 i=1 n=2 k=F2E6A159-5401-4b19-8966-5CC999BFAE91 kd=81CDE767-7418-44b6-8DDC-C30D4216EB2B "
.....moving 'launch' command to the wait_list.
.....smpd_handle_written: posting write(216 bytes) for command: "cmd=launch src=0 dest=1 tag=2 c=cpi s=0 a=0 d="C:\Program Files\MPICH2\bin" p="C:\Program Files\MPICH2\bin" q=0..1 i=0 n=2 k=F2E6A159-5401-4b19-8966-5CC999BFAE91 kd=81CDE767-7418-44b6-8DDC-C30D4216EB2B "
.....\SMPDU_Sock_post_writev
...../SMPDU_Sock_post_writev
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=launch src=0 dest=1 tag=2 c=cpi s=0 a=0 d="C:\Program Files\MPICH2\bin" p="C:\Program Files\MPICH2\bin" q=0..1 i=0 n=2 k=F2E6A159-5401-4b19-8966-5CC999BFAE91 kd=81CDE767-7418-44b6-8DDC-C30D4216EB2B "
.....moving 'launch' command to the wait_list.
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 134 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=result src=1 dest=0 tag=1 cmd_tag=1 cmd_orig=launch result=SUCCESS pg_id=F2E6A159-5401-4b19-8966-5CC999BFAE91 pg_rank=1 pg_ctx=0 "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = result
...... tag  = 1
...... ctx  = left
...... len  = 134
...... str  = cmd=result src=1 dest=0 tag=1 cmd_tag=1 cmd_orig=launch result=SUCCESS pg_id=F2E6A159-5401-4b19-8966-5CC999BFAE91 pg_rank=1 pg_ctx=0 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_result
.......successfully launched: 'cmd=launch src=0 dest=1 tag=1 c=cpi s=0 a=0 d="C:\Program Files\MPICH2\bin" p="C:\Program Files\MPICH2\bin" q=0..1 i=1 n=2 k=F2E6A159-5401-4b19-8966-5CC999BFAE91 kd=81CDE767-7418-44b6-8DDC-C30D4216EB2B '
.......\smpd_free_command
........\smpd_init_command
......../smpd_init_command
......./smpd_free_command
....../smpd_handle_result
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 134 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=result src=1 dest=0 tag=2 cmd_tag=2 cmd_orig=launch result=SUCCESS pg_id=F2E6A159-5401-4b19-8966-5CC999BFAE91 pg_rank=0 pg_ctx=1 "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = result
...... tag  = 2
...... ctx  = left
...... len  = 134
...... str  = cmd=result src=1 dest=0 tag=2 cmd_tag=2 cmd_orig=launch result=SUCCESS pg_id=F2E6A159-5401-4b19-8966-5CC999BFAE91 pg_rank=0 pg_ctx=1 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_result
.......successfully launched: 'cmd=launch src=0 dest=1 tag=2 c=cpi s=0 a=0 d="C:\Program Files\MPICH2\bin" p="C:\Program Files\MPICH2\bin" q=0..1 i=0 n=2 k=F2E6A159-5401-4b19-8966-5CC999BFAE91 kd=81CDE767-7418-44b6-8DDC-C30D4216EB2B '
.......root process launched, starting stdin redirection.
.......\smpd_make_socket_loop
........\smpd_get_hostname
......../smpd_get_hostname
......./smpd_make_socket_loop
.......\SMPDU_Sock_native_to_sock
......./SMPDU_Sock_native_to_sock
.......\smpd_create_context
........\smpd_init_context
.........\smpd_init_command
........./smpd_init_command
.........\SMPDU_Sock_set_user_ptr
........./SMPDU_Sock_set_user_ptr
......../smpd_init_context
......./smpd_create_context
.......\SMPDU_Sock_set_user_ptr
......./SMPDU_Sock_set_user_ptr
.......\SMPDU_Sock_post_read
........\SMPDU_Sock_post_readv
......../SMPDU_Sock_post_readv
......./SMPDU_Sock_post_read
.......\smpd_free_command
........\smpd_init_command
......../smpd_init_command
......./smpd_free_command
....../smpd_handle_result
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
....smpd_stdin_thread started.
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 105 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=init src=1 dest=0 tag=0 ctx_key=0 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 key=1 value=2 node_id=1 "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = init
...... tag  = 0
...... ctx  = left
...... len  = 105
...... str  = cmd=init src=1 dest=0 tag=0 ctx_key=0 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 key=1 value=2 node_id=1 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_init_command
.......\smpd_create_command
........\smpd_init_command
......../smpd_init_command
......./smpd_create_command
.......\smpd_add_command_int_arg
......./smpd_add_command_int_arg
.......\smpd_add_command_arg
......./smpd_add_command_arg
.......\get_name_key_value
......./get_name_key_value
.......init: 1:2:F2E6A159-5401-4b19-8966-5CC999BFAE91
.......sending reply to init command 'cmd=init src=1 dest=0 tag=0 ctx_key=0 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 key=1 value=2 node_id=1 '.
.......\smpd_add_command_arg
......./smpd_add_command_arg
.......sending result command to left context: "cmd=result src=0 dest=1 tag=3 cmd_tag=0 ctx_key=0 result=SUCCESS "
.......\smpd_post_write_command
........\smpd_package_command
......../smpd_package_command
........\SMPDU_Sock_get_sock_id
......../SMPDU_Sock_get_sock_id
........smpd_post_write_command on the left context sock 1552: 79 bytes for command: "cmd=result src=0 dest=1 tag=3 cmd_tag=0 ctx_key=0 result=SUCCESS "
........\SMPDU_Sock_post_writev
......../SMPDU_Sock_post_writev
......./smpd_post_write_command
....../smpd_handle_init_command
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=result src=0 dest=1 tag=3 cmd_tag=0 ctx_key=0 result=SUCCESS "
.....\smpd_free_command
......\smpd_init_command
....../smpd_init_command
...../smpd_free_command
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 105 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=init src=1 dest=0 tag=0 ctx_key=1 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 key=0 value=2 node_id=1 "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = init
...... tag  = 0
...... ctx  = left
...... len  = 105
...... str  = cmd=init src=1 dest=0 tag=0 ctx_key=1 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 key=0 value=2 node_id=1 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_init_command
.......\smpd_create_command
........\smpd_init_command
......../smpd_init_command
......./smpd_create_command
.......\smpd_add_command_int_arg
......./smpd_add_command_int_arg
.......\smpd_add_command_arg
......./smpd_add_command_arg
.......\get_name_key_value
......./get_name_key_value
.......init: 0:2:F2E6A159-5401-4b19-8966-5CC999BFAE91
.......sending reply to init command 'cmd=init src=1 dest=0 tag=0 ctx_key=1 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 key=0 value=2 node_id=1 '.
.......\smpd_add_command_arg
......./smpd_add_command_arg
.......sending result command to left context: "cmd=result src=0 dest=1 tag=4 cmd_tag=0 ctx_key=1 result=SUCCESS "
.......\smpd_post_write_command
........\smpd_package_command
......../smpd_package_command
........\SMPDU_Sock_get_sock_id
......../SMPDU_Sock_get_sock_id
........smpd_post_write_command on the left context sock 1552: 79 bytes for command: "cmd=result src=0 dest=1 tag=4 cmd_tag=0 ctx_key=1 result=SUCCESS "
........\SMPDU_Sock_post_writev
......../SMPDU_Sock_post_writev
......./smpd_post_write_command
....../smpd_handle_init_command
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=result src=0 dest=1 tag=4 cmd_tag=0 ctx_key=1 result=SUCCESS "
.....\smpd_free_command
......\smpd_init_command
....../smpd_init_command
...../smpd_free_command
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 135 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=stdout src=1 dest=0 tag=15 rank=0 first=1 data=456E74657220746865206E756D626572206F6620696E74657276616C733A2028302071756974732920 "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = stdout
...... tag  = 15
...... ctx  = left
...... len  = 135
...... str  = cmd=stdout src=1 dest=0 tag=15 rank=0 first=1 data=456E74657220746865206E756D626572206F6620696E74657276616C733A2028302071756974732920 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_stdout_command
.......\write_to_stdout
Enter the number of intervals: (0 quits) ......./write_to_stdout
....../smpd_handle_stdout_command
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 87 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=exit src=1 dest=0 tag=16 rank=0 code=123 kvs=F2E6A159-5401-4b19-8966-5CC999BFAE91 "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = exit
...... tag  = 16
...... ctx  = left
...... len  = 87
...... str  = cmd=exit src=1 dest=0 tag=16 rank=0 code=123 kvs=F2E6A159-5401-4b19-8966-5CC999BFAE91 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_exit_command
.......saving exit code: rank 0, exitcode 123, pg <F2E6A159-5401-4b19-8966-5CC999BFAE91>
.......\smpd_abort_job
........\smpd_command_destination
.........0 -> 0 : returning NULL context
......../smpd_command_destination
........\smpd_do_abort_job
.........\smpd_create_command
..........\smpd_init_command
........../smpd_init_command
........./smpd_create_command
.........\smpd_add_command_arg
........./smpd_add_command_arg
.........\smpd_add_command_int_arg
........./smpd_add_command_int_arg
.........\smpd_add_command_int_arg
........./smpd_add_command_int_arg
.........\smpd_add_command_arg
........./smpd_add_command_arg
.........\smpd_post_write_command
..........\smpd_package_command
........../smpd_package_command
..........\SMPDU_Sock_get_sock_id
........../SMPDU_Sock_get_sock_id
..........smpd_post_write_command on the left context sock 1552: 118 bytes for command: "cmd=suspend src=0 dest=1 tag=5 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 rank=1 exit_code=123 ctx_key=0 "
..........\SMPDU_Sock_post_writev
........../SMPDU_Sock_post_writev
........./smpd_post_write_command
......../smpd_do_abort_job
......./smpd_abort_job
....../smpd_handle_exit_command
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=suspend src=0 dest=1 tag=5 name=F2E6A159-5401-4b19-8966-5CC999BFAE91 rank=1 exit_code=123 ctx_key=0 "
.....moving 'suspend' command to the wait_list.
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....read command header
.....command header read, posting read for data: 93 bytes
.....\SMPDU_Sock_post_read
......\SMPDU_Sock_post_readv
....../SMPDU_Sock_post_readv
...../SMPDU_Sock_post_read
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=left
...\smpd_handle_op_read
....\smpd_state_reading_cmd
.....read command
.....\smpd_parse_command
...../smpd_parse_command
.....read command: "cmd=result src=1 dest=0 tag=17 cmd_tag=5 result="FAIL - unable to suspend process, error 5" "
.....\smpd_handle_command
......handling command:
...... src  = 1
...... dest = 0
...... cmd  = result
...... tag  = 17
...... ctx  = left
...... len  = 93
...... str  = cmd=result src=1 dest=0 tag=17 cmd_tag=5 result="FAIL - unable to suspend process, error 5" 
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_handle_result
.......suspend command result returned: FAIL - unable to suspend process, error 5
.......\smpd_handle_suspend_result
........suspended rank 0 already exited, no need to kill it.
........\smpd_create_command
.........\smpd_init_command
........./smpd_init_command
......../smpd_create_command
........\smpd_add_command_int_arg
......../smpd_add_command_int_arg
........\smpd_add_command_arg
......../smpd_add_command_arg
........\smpd_post_write_command
.........\smpd_package_command
........./smpd_package_command
.........\SMPDU_Sock_get_sock_id
........./SMPDU_Sock_get_sock_id
.........smpd_post_write_command on the left context sock 1552: 66 bytes for command: "cmd=kill src=0 dest=1 tag=6 exit_code=123 ctx_key=0 "
.........\SMPDU_Sock_post_writev
........./SMPDU_Sock_post_writev
......../smpd_post_write_command
......./smpd_handle_suspend_result
.......\smpd_free_command
........\smpd_init_command
......../smpd_init_command
......./smpd_free_command
....../smpd_handle_result
...../smpd_handle_command
.....\smpd_post_read_command
......\SMPDU_Sock_get_sock_id
....../SMPDU_Sock_get_sock_id
......posting a read for a command header on the left context, sock 1552
......\SMPDU_Sock_post_read
.......\SMPDU_Sock_post_readv
......./SMPDU_Sock_post_readv
....../SMPDU_Sock_post_read
...../smpd_post_read_command
..../smpd_state_reading_cmd
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_WRITE event.error = 0, result = 0, context=left
...\smpd_handle_op_write
....\smpd_state_writing_cmd
.....wrote command
.....command written to left: "cmd=kill src=0 dest=1 tag=6 exit_code=123 ctx_key=0 "
.....\smpd_free_command
......\smpd_init_command
....../smpd_init_command
...../smpd_free_command
..../smpd_state_writing_cmd
.../smpd_handle_op_write
...sock_waiting for the next event.
...\SMPDU_Sock_wait
....GetQueuedCompletionStatus failed, GetLastError: 64
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = -1, result = 0, context=left
...op_read error on left context: Error = -1

...\smpd_handle_op_read
....\smpd_state_reading_cmd_header
.....unable to read the cmd header on the left context, Error = -1
.
..../smpd_state_reading_cmd_header
.../smpd_handle_op_read
...SOCK_OP_READ failed - result = -1, closing left context.
...\SMPDU_Sock_post_close
....\SMPDU_Sock_post_read
.....\SMPDU_Sock_post_readv
......Error posting readv, An existing connection was forcibly closed by the remote host.(10054)
...../SMPDU_Sock_post_readv
..../SMPDU_Sock_post_read
.../SMPDU_Sock_post_close
...sock_waiting for the next event.
...\SMPDU_Sock_wait
.../SMPDU_Sock_wait
...SOCK_OP_CLOSE event.error = 0, result = 0, context=left
...\smpd_handle_op_close
....\smpd_get_state_string
..../smpd_get_state_string
....op_close received - SMPD_CLOSING state.
....Unaffiliated left context closing.
....\smpd_free_context
.....freeing left context.
.....\smpd_init_context
......\smpd_init_command
....../smpd_init_command
...../smpd_init_context
..../smpd_free_context
.../smpd_handle_op_close
...sock_waiting for the next event.
...\SMPDU_Sock_wait
mpiexec aborting job...
....\SMPDU_Sock_write
.....\SMPDU_Sock_writev
...../SMPDU_Sock_writev
..../SMPDU_Sock_write
.../SMPDU_Sock_wait
...SOCK_OP_READ event.error = 0, result = 0, context=MPIEXEC_ABORT
...\smpd_handle_op_read
....\smpd_state_reading_mpiexec_abort
.....\smpd_abort_job
......\smpd_command_destination
.......0 -> 0 : returning NULL context
....../smpd_command_destination
......\smpd_do_abort_job
.......job already aborted.
....../smpd_do_abort_job
...../smpd_abort_job
..../smpd_state_reading_mpiexec_abort
.../smpd_handle_op_read
...sock_waiting for the next event.
...\SMPDU_Sock_wait