デバックログ.txt - Job Arranger for Zabbix - Job Arranger Community Site

その他問い合わせ #2475 » デバックログ.txt

匿名ユーザー, 2017/02/28 13:24

 :20170228:125045.388 [INFO] [JASERVER000001] Starting Job Arranger Server. Job Arranger 3.0.0 (revision 7065).
 :20170228:125045.388 [DEBUG] In ja_init_selfmon_collector()
 :20170228:125045.388 [DEBUG] ja_init_selfmon_collector() size:3248
 :20170228:125045.388 [DEBUG] End of ja_init_selfmon_collector() collector:0x7f0a2d472000
 :20170228:125045.388 [DEBUG] In is_ip4() ip:'192.168.33.11'
 :20170228:125045.388 [DEBUG] End of is_ip4():SUCCEED
 :20170228:125045.390 [DEBUG] In ja_log() message_id: JASERVER000003 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.390 [INFO] [JASERVER000003] server #0 started [main process]
 :20170228:125045.396 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.396 [INFO] [JASERVER000004] server #10 started [jobnet boot #1]
 :20170228:125045.396 [DEBUG] In main_jaboot_loop() process_type:'jobnet boot' process_num:1
 :20170228:125045.396 [DEBUG] In DBconnect() flag:0
 :20170228:125045.397 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.397 [INFO] [JASERVER000004] server #12 started [self-monitoring #1]
 :20170228:125045.397 [DEBUG] In main_jaselfmon_loop()
 :20170228:125045.397 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125045.397 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125045.397 [DEBUG] sleeping for 1 seconds
 :20170228:125045.397 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.397 [INFO] [JASERVER000004] server #11 started [message send #1]
 :20170228:125045.398 [DEBUG] In main_jamsgsnd_loop() process_type:'message send' process_num:1
 :20170228:125045.398 [DEBUG] In DBconnect() flag:0
 :20170228:125045.398 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.398 [INFO] [JASERVER000004] server #7 started [job trapper #4]
 :20170228:125045.398 [DEBUG] In main_jatrapper_loop()
 :20170228:125045.399 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.399 [INFO] [JASERVER000004] server #2 started [start the job #1]
 :20170228:125045.399 [DEBUG] In main_jarun_loop() process_type:'start the job' process_num:1
 :20170228:125045.399 [DEBUG] In DBconnect() flag:0
 :20170228:125045.400 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.400 [INFO] [JASERVER000004] server #3 started [check the running job #1]
 :20170228:125045.400 [DEBUG] In main_jajob_loop() process_type:'check the running job' process_num:1
 :20170228:125045.400 [DEBUG] In DBconnect() flag:0
 :20170228:125045.401 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.401 [INFO] [JASERVER000004] server #4 started [job trapper #1]
 :20170228:125045.401 [DEBUG] In main_jatrapper_loop()
 :20170228:125045.401 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.402 [INFO] [JASERVER000004] server #5 started [job trapper #2]
 :20170228:125045.402 [DEBUG] In main_jatrapper_loop()
 :20170228:125045.402 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.402 [INFO] [JASERVER000004] server #6 started [job trapper #3]
 :20170228:125045.403 [DEBUG] In main_jatrapper_loop()
 :20170228:125045.403 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.409 [INFO] [JASERVER000004] server #9 started [job loader #1]
 :20170228:125045.409 [DEBUG] In main_jaloader_loop() process_type:'job loader' process_num:1
 :20170228:125045.409 [DEBUG] In DBconnect() flag:0
 :20170228:125045.410 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.410 [INFO] [JASERVER000004] server #1 started [start and check the jobnet #1]
 :20170228:125045.410 [DEBUG] In main_jajobnet_loop() process_type:'start and check the jobnet' process_num:1
 :20170228:125045.410 [DEBUG] In DBconnect() flag:0
 :20170228:125045.411 [DEBUG] In ja_log() message_id: JASERVER000004 inner_jobnet_id: 0 inner_job_id: 0
 :20170228:125045.411 [INFO] [JASERVER000004] server #8 started [job trapper #5]
 :20170228:125045.411 [DEBUG] In main_jatrapper_loop()
 :20170228:125045.419 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125045.420 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125045.420 [DEBUG] End of DBconnect():0
 :20170228:125045.420 [DEBUG] In get_zbxsnd_parameters()
 :20170228:125045.420 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_ZABBIX_IP']
 :20170228:125045.421 [DEBUG] End of DBconnect():0
 :20170228:125045.421 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125045.421 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125045.421 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_ZABBIX_PORT']
 :20170228:125045.422 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000975 sec.
 :20170228:125045.422 [DEBUG] End of process_jajob()
 :20170228:125045.422 [DEBUG] sleeping for 1 seconds
 :20170228:125045.422 [DEBUG] In ja_check_number(10051)
 :20170228:125045.422 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_ZABBIX_HOST']
 :20170228:125045.422 [DEBUG] End of DBconnect():0
 :20170228:125045.423 [DEBUG] In get_jobnet_keep_span()
 :20170228:125045.423 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'JOBNET_KEEP_SPAN']
 :20170228:125045.423 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_ITEM_KEY']
 :20170228:125045.423 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_SENDER']
 :20170228:125045.424 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_RETRY']
 :20170228:125045.424 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125045.424 [DEBUG] In get_joblog_keep_span()
 :20170228:125045.424 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'JOBLOG_KEEP_SPAN']
 :20170228:125045.425 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_RETRY_COUNT']
 :20170228:125045.426 [DEBUG] In get_purge_date(60)
 :20170228:125045.426 [DEBUG] In get_purge_date(43200)
 :20170228:125045.426 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125045.426 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125045.426 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125045.426 [DEBUG] End of DBconnect():0
 :20170228:125045.426 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125045.427 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'ZBXSND_RETRY_INTERVAL']
 :20170228:125045.427 [DEBUG] End of DBconnect():0
 :20170228:125045.427 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125045.427 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.001006 sec.
 :20170228:125045.428 [DEBUG] End of process_jarun()
 :20170228:125045.428 [DEBUG] sleeping for 1 seconds
 :20170228:125045.428 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.001963 seconds while processing rules
 :20170228:125045.428 [DEBUG] In joblog_purge(201701291250)
 :20170228:125045.428 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125045.428 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'SNDMSG_KEEP_SPAN']
 :20170228:125045.428 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.001199 sec.
 :20170228:125045.429 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125045.429 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_ZABBIX_IP:      [127.0.0.1]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_ZABBIX_PORT:    [10051]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_ZABBIX_HOST:    [Zabbix server]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_ITEM_KEY:       [jasender]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_SENDER:         [zabbix_sender]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_RETRY:          [0]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_RETRY_COUNT:    [3]
 :20170228:125045.429 [DEBUG] =DEBUG= ZBXSND_RETRY_INTERVAL: [5]
 :20170228:125045.429 [DEBUG] =DEBUG= SNDMSG_KEEP_SPAN:      [1440]
 :20170228:125045.429 [DEBUG] In message_purge()
 :20170228:125045.429 [DEBUG] In get_purge_date(1440)
 :20170228:125045.429 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.429 [DEBUG] jobnet boot #1 (joblog purge) spent 0.001395 seconds while processing rules
 :20170228:125045.429 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125045.429 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125045.430 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000535 seconds while processing rules
 :20170228:125045.430 [DEBUG] sleeping for 1 seconds
 :20170228:125045.430 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.430 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125045.431 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125045.431 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.431 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.431 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.431 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.431 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125045.432 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125045.432 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.432 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.433 [DEBUG] message send #1 (message purge) spent 0.003625 seconds while processing rules
 :20170228:125045.433 [DEBUG] In message_send()
 :20170228:125045.433 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125045 order by retry_date, message_date]
 :20170228:125045.433 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.433 [DEBUG] End of process_jajobnet_summary()
 :20170228:125045.433 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125045.434 [DEBUG] message send #1 (message send) spent 0.000813 seconds while processing rules
 :20170228:125045.434 [DEBUG] sleeping for 1 seconds
 :20170228:125045.434 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000497 sec.
 :20170228:125045.434 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125045.434 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.434 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125045.434 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125045.435 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000343 sec.
 :20170228:125045.435 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125045.435 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.435 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125045.435 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.435 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125045.435 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125045.436 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000582 sec.
 :20170228:125045.436 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125045.436 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.436 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125045.436 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125045.436 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125045.437 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125045.437 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000737 sec.
 :20170228:125045.437 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125045.437 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125045.438 [DEBUG] End of process_jajobnet()
 :20170228:125045.438 [DEBUG] sleeping for 1 seconds
 :20170228:125045.440 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125045.441 [DEBUG] End of DBconnect():0
 :20170228:125045.441 [DEBUG] In get_load_span()
 :20170228:125045.441 [DEBUG] query [txnlev:0] [select value from ja_parameter_table where parameter_name = 'JOBNET_LOAD_SPAN']
 :20170228:125045.441 [DEBUG] In jobnet_load_schedule(60)
 :20170228:125045.441 [DEBUG] In get_search_date(60)
 :20170228:125045.441 [DEBUG] query [txnlev:0] [select schedule_id, update_date from ja_schedule_control_table where valid_flag = 1]
 :20170228:125045.442 [DEBUG] job loader #1 (scheduled start) spent 0.000328 seconds while processing rules
 :20170228:125045.442 [DEBUG] In jobnet_load_immediate()
 :20170228:125045.442 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125045.442 [DEBUG] job loader #1 (immediate start) spent 0.000487 seconds while processing rules
 :20170228:125045.442 [DEBUG] sleeping for 1 seconds
 :20170228:125046.398 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125046.398 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125046.398 [DEBUG] sleeping for 1 seconds
 :20170228:125046.423 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125046.425 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.001407 sec.
 :20170228:125046.425 [DEBUG] End of process_jajob()
 :20170228:125046.425 [DEBUG] sleeping for 1 seconds
 :20170228:125046.428 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125046.430 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.001191 sec.
 :20170228:125046.430 [DEBUG] End of process_jarun()
 :20170228:125046.430 [DEBUG] sleeping for 1 seconds
 :20170228:125046.430 [DEBUG] In get_purge_date(60)
 :20170228:125046.430 [DEBUG] In get_purge_date(43200)
 :20170228:125046.430 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125046.430 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125046.431 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.001020 seconds while processing rules
 :20170228:125046.431 [DEBUG] In joblog_purge(201701291250)
 :20170228:125046.431 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125046.432 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000766 seconds while processing rules
 :20170228:125046.432 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125046.432 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125046.433 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000978 seconds while processing rules
 :20170228:125046.433 [DEBUG] sleeping for 1 seconds
 :20170228:125046.434 [DEBUG] In message_purge()
 :20170228:125046.434 [DEBUG] In get_purge_date(1440)
 :20170228:125046.434 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.434 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125046.435 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.435 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.436 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125046.437 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.437 [DEBUG] message send #1 (message purge) spent 0.003201 seconds while processing rules
 :20170228:125046.437 [DEBUG] In message_send()
 :20170228:125046.437 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125046 order by retry_date, message_date]
 :20170228:125046.438 [DEBUG] message send #1 (message send) spent 0.000827 seconds while processing rules
 :20170228:125046.438 [DEBUG] sleeping for 1 seconds
 :20170228:125046.438 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125046.439 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000682 sec.
 :20170228:125046.439 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125046.439 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.439 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.440 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125046.440 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.440 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.441 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125046.441 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.442 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.442 [DEBUG] End of process_jajobnet_summary()
 :20170228:125046.442 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125046.443 [DEBUG] In jobnet_load_immediate()
 :20170228:125046.443 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125046.443 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000978 sec.
 :20170228:125046.443 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125046.443 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.444 [DEBUG] job loader #1 (immediate start) spent 0.001190 seconds while processing rules
 :20170228:125046.444 [DEBUG] sleeping for 1 seconds
 :20170228:125046.444 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125046.444 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125046.445 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000650 sec.
 :20170228:125046.445 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125046.445 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.446 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125046.446 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.446 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125046.446 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125046.447 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000717 sec.
 :20170228:125046.447 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125046.447 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.447 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125046.447 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125046.448 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125046.448 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125046.449 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000643 sec.
 :20170228:125046.449 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125046.449 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125046.450 [DEBUG] End of process_jajobnet()
 :20170228:125046.450 [DEBUG] sleeping for 1 seconds
 :20170228:125047.399 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125047.399 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125047.399 [DEBUG] sleeping for 1 seconds
 :20170228:125047.425 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125047.426 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000945 sec.
 :20170228:125047.426 [DEBUG] End of process_jajob()
 :20170228:125047.426 [DEBUG] sleeping for 1 seconds
 :20170228:125047.430 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125047.431 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000565 sec.
 :20170228:125047.431 [DEBUG] End of process_jarun()
 :20170228:125047.431 [DEBUG] sleeping for 1 seconds
 :20170228:125047.434 [DEBUG] In get_purge_date(60)
 :20170228:125047.434 [DEBUG] In get_purge_date(43200)
 :20170228:125047.434 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125047.434 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125047.435 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000639 seconds while processing rules
 :20170228:125047.435 [DEBUG] In joblog_purge(201701291250)
 :20170228:125047.435 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125047.436 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000427 seconds while processing rules
 :20170228:125047.436 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125047.436 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125047.436 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000733 seconds while processing rules
 :20170228:125047.436 [DEBUG] sleeping for 1 seconds
 :20170228:125047.438 [DEBUG] In message_purge()
 :20170228:125047.438 [DEBUG] In get_purge_date(1440)
 :20170228:125047.438 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.438 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125047.439 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.440 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.440 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125047.441 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.441 [DEBUG] message send #1 (message purge) spent 0.002831 seconds while processing rules
 :20170228:125047.441 [DEBUG] In message_send()
 :20170228:125047.441 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125047 order by retry_date, message_date]
 :20170228:125047.442 [DEBUG] message send #1 (message send) spent 0.000966 seconds while processing rules
 :20170228:125047.442 [DEBUG] sleeping for 1 seconds
 :20170228:125047.445 [DEBUG] In jobnet_load_immediate()
 :20170228:125047.445 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125047.446 [DEBUG] job loader #1 (immediate start) spent 0.001272 seconds while processing rules
 :20170228:125047.446 [DEBUG] sleeping for 1 seconds
 :20170228:125047.450 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125047.451 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.001069 sec.
 :20170228:125047.451 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125047.451 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.451 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.451 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125047.451 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.451 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.452 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125047.452 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.452 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.452 [DEBUG] End of process_jajobnet_summary()
 :20170228:125047.452 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125047.452 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000230 sec.
 :20170228:125047.452 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125047.452 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.453 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125047.453 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125047.453 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000347 sec.
 :20170228:125047.453 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125047.453 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.454 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125047.454 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.454 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125047.454 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125047.454 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000311 sec.
 :20170228:125047.454 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125047.454 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.454 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125047.454 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125047.455 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125047.455 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125047.455 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000278 sec.
 :20170228:125047.455 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125047.455 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125047.455 [DEBUG] End of process_jajobnet()
 :20170228:125047.455 [DEBUG] sleeping for 1 seconds
 :20170228:125048.400 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125048.400 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125048.400 [DEBUG] sleeping for 1 seconds
 :20170228:125048.427 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125048.428 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000427 sec.
 :20170228:125048.428 [DEBUG] End of process_jajob()
 :20170228:125048.428 [DEBUG] sleeping for 1 seconds
 :20170228:125048.431 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125048.432 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000368 sec.
 :20170228:125048.432 [DEBUG] End of process_jarun()
 :20170228:125048.432 [DEBUG] sleeping for 1 seconds
 :20170228:125048.437 [DEBUG] In get_purge_date(60)
 :20170228:125048.437 [DEBUG] In get_purge_date(43200)
 :20170228:125048.437 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125048.437 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125048.438 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000389 seconds while processing rules
 :20170228:125048.438 [DEBUG] In joblog_purge(201701291250)
 :20170228:125048.438 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125048.438 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000521 seconds while processing rules
 :20170228:125048.438 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125048.438 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125048.439 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000316 seconds while processing rules
 :20170228:125048.439 [DEBUG] sleeping for 1 seconds
 :20170228:125048.442 [DEBUG] In message_purge()
 :20170228:125048.442 [DEBUG] In get_purge_date(1440)
 :20170228:125048.442 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.443 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125048.443 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.444 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.444 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125048.444 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.444 [DEBUG] message send #1 (message purge) spent 0.002313 seconds while processing rules
 :20170228:125048.445 [DEBUG] In message_send()
 :20170228:125048.445 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125048 order by retry_date, message_date]
 :20170228:125048.445 [DEBUG] message send #1 (message send) spent 0.000397 seconds while processing rules
 :20170228:125048.445 [DEBUG] sleeping for 1 seconds
 :20170228:125048.447 [DEBUG] In jobnet_load_immediate()
 :20170228:125048.447 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125048.448 [DEBUG] In already_start_check_immediate(1500000000000000070)
 :20170228:125048.448 [DEBUG] query [txnlev:0] [select count(*) from ja_run_jobnet_summary_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125048.448 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.448 [DEBUG] In load_job_definition(1500000000000000070 1500000000000000070 JBN_SRV_041 20170227173447 0 1)
 :20170228:125048.448 [DEBUG] query [txnlev:1] [select jobnet_id, job_id, update_date, job_type, point_x, point_y, job_name, method_flag, force_flag, continue_flag, run_user, run_user_password from ja_job_control_table where jobnet_id = 'JBN_SRV_041' and update_date = 20170227173447]
 :20170228:125048.449 [DEBUG] In get_next_id(20)
 :20170228:125048.449 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.449 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.449 [DEBUG] In get_boot_count(JBN_SRV_041 END-1 20170227173447)
 :20170228:125048.449 [DEBUG] query [txnlev:1] [select count(*) from ja_flow_control_table where jobnet_id = 'JBN_SRV_041' and end_job_id = 'END-1' and update_date = 20170227173447]
 :20170228:125048.450 [DEBUG] query [txnlev:1] [insert into ja_run_job_table ( inner_job_id, inner_jobnet_id, inner_jobnet_main_id, inner_job_id_fs_link, invo_flag, job_type, test_flag, method_flag, force_flag, timeout_flag, status, boot_count, end_count, start_time, end_time, point_x, point_y, job_id, job_name, continue_flag, run_user, run_user_password) values (549,1500000000000000070,1500000000000000070,0, 0, 1, 0, 0, 0, 0, 0, 1, 0, 0, 0, 452, 50, 'END-1', '', 0, '', '')]
 :20170228:125048.450 [DEBUG] In load_icon_end(1500000000000000070 549 JBN_SRV_041 END-1 20170227173447)
 :20170228:125048.451 [DEBUG] query [txnlev:1] [insert into ja_run_icon_end_table ( inner_job_id, inner_jobnet_id, jobnet_stop_flag, jobnet_stop_code) select '549','1500000000000000070', jobnet_stop_flag, jobnet_stop_code from ja_icon_end_table where jobnet_id = 'JBN_SRV_041' and job_id = 'END-1' and update_date = 20170227173447]
 :20170228:125048.454 [DEBUG] query [txnlev:1] [select jobnet_stop_flag from ja_icon_end_table where jobnet_id = 'JBN_SRV_041' and job_id = 'END-1' and update_date = 20170227173447]
 :20170228:125048.455 [DEBUG] In get_next_id(20)
 :20170228:125048.455 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.456 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125048.457 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.001065 sec.
 :20170228:125048.457 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125048.457 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.457 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.457 [DEBUG] In get_next_id(20)
 :20170228:125048.457 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.457 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.458 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.458 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125048.458 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.458 [DEBUG] In get_boot_count(JBN_SRV_041 JB_SRV_041_001 20170227173447)
 :20170228:125048.458 [DEBUG] query [txnlev:1] [select count(*) from ja_flow_control_table where jobnet_id = 'JBN_SRV_041' and end_job_id = 'JB_SRV_041_001' and update_date = 20170227173447]
 :20170228:125048.458 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.459 [DEBUG] query [txnlev:1] [insert into ja_run_job_table ( inner_job_id, inner_jobnet_id, inner_jobnet_main_id, inner_job_id_fs_link, invo_flag, job_type, test_flag, method_flag, force_flag, timeout_flag, status, boot_count, end_count, start_time, end_time, point_x, point_y, job_id, job_name, continue_flag, run_user, run_user_password) values (550,1500000000000000070,1500000000000000070,551, 0, 4, 0, 0, 0, 0, 0, 1, 0, 0, 0, 148, 50, 'JB_SRV_041_001', 'Jenkins?ݒ???o?b?N?A?b?v???s??', 0, '', '')]
 :20170228:125048.459 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125048.459 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.459 [DEBUG] In load_icon_job(1500000000000000070 550 JBN_SRV_041 JB_SRV_041_001 20170227173447)
 :20170228:125048.459 [DEBUG] query [txnlev:1] [insert into ja_run_icon_job_table ( inner_job_id, inner_jobnet_id, host_flag, stop_flag, command_type, timeout, host_name, stop_code) select '550','1500000000000000070', host_flag, stop_flag, command_type, timeout, host_name, stop_code from ja_icon_job_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_001' and update_date = 20170227173447]
 :20170228:125048.459 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.460 [DEBUG] End of process_jajobnet_summary()
 :20170228:125048.460 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125048.460 [DEBUG] query [txnlev:1] [insert into ja_run_job_command_table ( inner_job_id, inner_jobnet_id, command_cls, command) select '550','1500000000000000070', command_cls, command from ja_job_command_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_001' and update_date = 20170227173447]
 :20170228:125048.460 [DEBUG] In load_value(1500000000000000070 550 JBN_SRV_041 JB_SRV_041_001 20170227173447)
 :20170228:125048.460 [DEBUG] query [txnlev:1] [insert into ja_run_value_job_table ( inner_job_id, inner_jobnet_id, value_name, value) select '550','1500000000000000070', value_name, value from ja_value_job_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_001' and update_date = 20170227173447]
 :20170228:125048.460 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000644 sec.
 :20170228:125048.460 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125048.460 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.461 [DEBUG] query [txnlev:1] [insert into ja_run_value_jobcon_table ( inner_job_id, inner_jobnet_id, value_name) select '550','1500000000000000070', value_name from ja_value_jobcon_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_001' and update_date = 20170227173447]
 :20170228:125048.461 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125048.461 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125048.461 [DEBUG] In get_next_id(20)
 :20170228:125048.461 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.461 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000487 sec.
 :20170228:125048.461 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125048.461 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.462 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.462 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125048.462 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.462 [DEBUG] In get_next_id(20)
 :20170228:125048.462 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.462 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125048.462 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125048.463 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.463 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000443 sec.
 :20170228:125048.463 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125048.463 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.463 [DEBUG] In get_boot_count(JBN_SRV_041 JB_SRV_041_002 20170227173447)
 :20170228:125048.464 [DEBUG] query [txnlev:1] [select count(*) from ja_flow_control_table where jobnet_id = 'JBN_SRV_041' and end_job_id = 'JB_SRV_041_002' and update_date = 20170227173447]
 :20170228:125048.464 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125048.464 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125048.465 [DEBUG] query [txnlev:1] [insert into ja_run_job_table ( inner_job_id, inner_jobnet_id, inner_jobnet_main_id, inner_job_id_fs_link, invo_flag, job_type, test_flag, method_flag, force_flag, timeout_flag, status, boot_count, end_count, start_time, end_time, point_x, point_y, job_id, job_name, continue_flag, run_user, run_user_password) values (552,1500000000000000070,1500000000000000070,553, 0, 4, 0, 2, 0, 0, 0, 1, 0, 0, 0, 251, 50, 'JB_SRV_041_002', 'Jenkins?ݒ???o?b?N?A?b?v???I?u?W?F?N?g?X?g???[?W?ɃR?s?[????', 0, '', '')]
 :20170228:125048.465 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125048.465 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125048.465 [DEBUG] In load_icon_job(1500000000000000070 552 JBN_SRV_041 JB_SRV_041_002 20170227173447)
 :20170228:125048.465 [DEBUG] query [txnlev:1] [insert into ja_run_icon_job_table ( inner_job_id, inner_jobnet_id, host_flag, stop_flag, command_type, timeout, host_name, stop_code) select '552','1500000000000000070', host_flag, stop_flag, command_type, timeout, host_name, stop_code from ja_icon_job_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_002' and update_date = 20170227173447]
 :20170228:125048.465 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000743 sec.
 :20170228:125048.466 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125048.466 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.466 [DEBUG] End of process_jajobnet()
 :20170228:125048.466 [DEBUG] sleeping for 1 seconds
 :20170228:125048.466 [DEBUG] query [txnlev:1] [insert into ja_run_job_command_table ( inner_job_id, inner_jobnet_id, command_cls, command) select '552','1500000000000000070', command_cls, command from ja_job_command_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_002' and update_date = 20170227173447]
 :20170228:125048.469 [DEBUG] In load_value(1500000000000000070 552 JBN_SRV_041 JB_SRV_041_002 20170227173447)
 :20170228:125048.469 [DEBUG] query [txnlev:1] [insert into ja_run_value_job_table ( inner_job_id, inner_jobnet_id, value_name, value) select '552','1500000000000000070', value_name, value from ja_value_job_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_002' and update_date = 20170227173447]
 :20170228:125048.470 [DEBUG] query [txnlev:1] [insert into ja_run_value_jobcon_table ( inner_job_id, inner_jobnet_id, value_name) select '552','1500000000000000070', value_name from ja_value_jobcon_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_002' and update_date = 20170227173447]
 :20170228:125048.472 [DEBUG] In get_next_id(20)
 :20170228:125048.472 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.472 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.473 [DEBUG] In get_next_id(20)
 :20170228:125048.473 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.473 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.473 [DEBUG] In get_boot_count(JBN_SRV_041 JB_SRV_041_003 20170227173447)
 :20170228:125048.473 [DEBUG] query [txnlev:1] [select count(*) from ja_flow_control_table where jobnet_id = 'JBN_SRV_041' and end_job_id = 'JB_SRV_041_003' and update_date = 20170227173447]
 :20170228:125048.474 [DEBUG] query [txnlev:1] [insert into ja_run_job_table ( inner_job_id, inner_jobnet_id, inner_jobnet_main_id, inner_job_id_fs_link, invo_flag, job_type, test_flag, method_flag, force_flag, timeout_flag, status, boot_count, end_count, start_time, end_time, point_x, point_y, job_id, job_name, continue_flag, run_user, run_user_password) values (554,1500000000000000070,1500000000000000070,555, 0, 4, 0, 0, 0, 0, 0, 1, 0, 0, 0, 351, 50, 'JB_SRV_041_003', '?ߋ?1???ȑO??Jenkins?ݒ???o?b?N?A?b?v???폜????', 0, '', '')]
 :20170228:125048.474 [DEBUG] In load_icon_job(1500000000000000070 554 JBN_SRV_041 JB_SRV_041_003 20170227173447)
 :20170228:125048.474 [DEBUG] query [txnlev:1] [insert into ja_run_icon_job_table ( inner_job_id, inner_jobnet_id, host_flag, stop_flag, command_type, timeout, host_name, stop_code) select '554','1500000000000000070', host_flag, stop_flag, command_type, timeout, host_name, stop_code from ja_icon_job_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_003' and update_date = 20170227173447]
 :20170228:125048.474 [DEBUG] query [txnlev:1] [insert into ja_run_job_command_table ( inner_job_id, inner_jobnet_id, command_cls, command) select '554','1500000000000000070', command_cls, command from ja_job_command_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_003' and update_date = 20170227173447]
 :20170228:125048.475 [DEBUG] In load_value(1500000000000000070 554 JBN_SRV_041 JB_SRV_041_003 20170227173447)
 :20170228:125048.475 [DEBUG] query [txnlev:1] [insert into ja_run_value_job_table ( inner_job_id, inner_jobnet_id, value_name, value) select '554','1500000000000000070', value_name, value from ja_value_job_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_003' and update_date = 20170227173447]
 :20170228:125048.475 [DEBUG] query [txnlev:1] [insert into ja_run_value_jobcon_table ( inner_job_id, inner_jobnet_id, value_name) select '554','1500000000000000070', value_name from ja_value_jobcon_table where jobnet_id = 'JBN_SRV_041' and job_id = 'JB_SRV_041_003' and update_date = 20170227173447]
 :20170228:125048.476 [DEBUG] In get_next_id(20)
 :20170228:125048.476 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 20 for update]
 :20170228:125048.476 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 20]
 :20170228:125048.476 [DEBUG] In get_boot_count(JBN_SRV_041 START 20170227173447)
 :20170228:125048.476 [DEBUG] query [txnlev:1] [select count(*) from ja_flow_control_table where jobnet_id = 'JBN_SRV_041' and end_job_id = 'START' and update_date = 20170227173447]
 :20170228:125048.476 [DEBUG] query [txnlev:1] [insert into ja_run_job_table ( inner_job_id, inner_jobnet_id, inner_jobnet_main_id, inner_job_id_fs_link, invo_flag, job_type, test_flag, method_flag, force_flag, timeout_flag, status, boot_count, end_count, start_time, end_time, point_x, point_y, job_id, job_name, continue_flag, run_user, run_user_password) values (556,1500000000000000070,1500000000000000070,0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 42, 50, 'START', '', 0, '', '')]
 :20170228:125048.477 [DEBUG] query [txnlev:1] [select start_job_id, end_job_id, flow_type, flow_width from ja_flow_control_table where jobnet_id = 'JBN_SRV_041' and update_date = 20170227173447]
 :20170228:125048.477 [DEBUG] In get_next_id(30)
 :20170228:125048.477 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 30 for update]
 :20170228:125048.477 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 30]
 :20170228:125048.478 [DEBUG] In get_flow_inner_job_id(1500000000000000070 JB_SRV_041_001)
 :20170228:125048.478 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'JB_SRV_041_001']
 :20170228:125048.478 [DEBUG] In get_flow_inner_job_id(1500000000000000070 JB_SRV_041_002)
 :20170228:125048.478 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'JB_SRV_041_002']
 :20170228:125048.478 [DEBUG] query [txnlev:1] [insert into ja_run_flow_table ( inner_flow_id, inner_jobnet_id, start_inner_job_id, end_inner_job_id, flow_type, flow_width) values (291,1500000000000000070,550,552, 0, 0)]
 :20170228:125048.479 [DEBUG] In get_next_id(30)
 :20170228:125048.479 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 30 for update]
 :20170228:125048.479 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 30]
 :20170228:125048.479 [DEBUG] In get_flow_inner_job_id(1500000000000000070 JB_SRV_041_002)
 :20170228:125048.479 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'JB_SRV_041_002']
 :20170228:125048.480 [DEBUG] In get_flow_inner_job_id(1500000000000000070 JB_SRV_041_003)
 :20170228:125048.480 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'JB_SRV_041_003']
 :20170228:125048.480 [DEBUG] query [txnlev:1] [insert into ja_run_flow_table ( inner_flow_id, inner_jobnet_id, start_inner_job_id, end_inner_job_id, flow_type, flow_width) values (292,1500000000000000070,552,554, 0, 0)]
 :20170228:125048.480 [DEBUG] In get_next_id(30)
 :20170228:125048.480 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 30 for update]
 :20170228:125048.481 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 30]
 :20170228:125048.481 [DEBUG] In get_flow_inner_job_id(1500000000000000070 JB_SRV_041_003)
 :20170228:125048.481 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'JB_SRV_041_003']
 :20170228:125048.481 [DEBUG] In get_flow_inner_job_id(1500000000000000070 END-1)
 :20170228:125048.481 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'END-1']
 :20170228:125048.482 [DEBUG] query [txnlev:1] [insert into ja_run_flow_table ( inner_flow_id, inner_jobnet_id, start_inner_job_id, end_inner_job_id, flow_type, flow_width) values (293,1500000000000000070,554,549, 0, 0)]
 :20170228:125048.482 [DEBUG] In get_next_id(30)
 :20170228:125048.482 [DEBUG] query [txnlev:1] [select nextid from ja_index_table where count_id = 30 for update]
 :20170228:125048.482 [DEBUG] query [txnlev:1] [update ja_index_table set nextid = nextid + 1 where count_id = 30]
 :20170228:125048.482 [DEBUG] In get_flow_inner_job_id(1500000000000000070 START)
 :20170228:125048.482 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'START']
 :20170228:125048.483 [DEBUG] In get_flow_inner_job_id(1500000000000000070 JB_SRV_041_001)
 :20170228:125048.483 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_id = 'JB_SRV_041_001']
 :20170228:125048.483 [DEBUG] query [txnlev:1] [insert into ja_run_flow_table ( inner_flow_id, inner_jobnet_id, start_inner_job_id, end_inner_job_id, flow_type, flow_width) values (294,1500000000000000070,556,550, 0, 0)]
 :20170228:125048.483 [DEBUG] In load_sub_jobnet_definition(1500000000000000070 1)
 :20170228:125048.483 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_main_id = 1500000000000000070 and job_type = 5 and invo_flag = 0]
 :20170228:125048.484 [DEBUG] query [txnlev:1] [insert into ja_run_jobnet_summary_table ( inner_jobnet_id, update_date, invo_flag, run_type, status, job_status, jobnet_abort_flag, load_status, scheduled_time, start_time, end_time, public_flag, multiple_start_up, jobnet_id, user_name, jobnet_name, memo, execution_user_name, virtual_time, virtual_start_time, virtual_end_time, start_pending_flag, initial_scheduled_time) values (1500000000000000070, 20170227173447, 1, 1, 0, 0, 0, 0, 0, 0, 0, 0, 1, 'JBN_SRV_041', 'Admin', 'Jenkins?o?b?N?A?b?v', 'Jenkins?ݒ???o?b?N?A?b?v???s??', 'Admin', 0, 0, 0, 0, 0)]
 :20170228:125048.485 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125048.487 [DEBUG] job loader #1 (immediate start) spent 0.040188 seconds while processing rules
 :20170228:125048.487 [DEBUG] sleeping for 1 seconds
 :20170228:125049.401 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125049.401 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125049.401 [DEBUG] sleeping for 1 seconds
 :20170228:125049.428 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125049.429 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000654 sec.
 :20170228:125049.429 [DEBUG] End of process_jajob()
 :20170228:125049.429 [DEBUG] sleeping for 1 seconds
 :20170228:125049.432 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125049.433 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000587 sec.
 :20170228:125049.433 [DEBUG] End of process_jarun()
 :20170228:125049.433 [DEBUG] sleeping for 1 seconds
 :20170228:125049.439 [DEBUG] In get_purge_date(60)
 :20170228:125049.439 [DEBUG] In get_purge_date(43200)
 :20170228:125049.439 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125049.439 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125049.440 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000823 seconds while processing rules
 :20170228:125049.440 [DEBUG] In joblog_purge(201701291250)
 :20170228:125049.440 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125049.441 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000358 seconds while processing rules
 :20170228:125049.441 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125049.441 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125049.441 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.442 [DEBUG] -DEBUG- get ja_run_jobnet_summary_table data: run_type[1] scheduled_time[0] now_date[201702281250] multiple_start_up[1] load_status[0] start_pending_flag[0]
 :20170228:125049.442 [DEBUG] In get_running_jobnet(JBN_SRV_041)
 :20170228:125049.442 [DEBUG] query [txnlev:1] [select count(*) from ja_run_jobnet_summary_table where jobnet_id = 'JBN_SRV_041' and status in(1, 2)]
 :20170228:125049.442 [DEBUG] In start_jobnet(1500000000000000070 JBN_SRV_041)
 :20170228:125049.442 [DEBUG] query [txnlev:1] [update ja_run_jobnet_summary_table set status = 1, load_status = 0 where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.443 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.445 [DEBUG] In message_purge()
 :20170228:125049.445 [DEBUG] In get_purge_date(1440)
 :20170228:125049.445 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.446 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125049.447 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.447 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.447 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125049.448 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.448 [DEBUG] message send #1 (message purge) spent 0.002640 seconds while processing rules
 :20170228:125049.448 [DEBUG] In message_send()
 :20170228:125049.448 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125049 order by retry_date, message_date]
 :20170228:125049.448 [DEBUG] message send #1 (message send) spent 0.000387 seconds while processing rules
 :20170228:125049.448 [DEBUG] sleeping for 1 seconds
 :20170228:125049.449 [DEBUG] jobnet boot #1 (jobnet start) spent 0.008562 seconds while processing rules
 :20170228:125049.449 [DEBUG] sleeping for 1 seconds
 :20170228:125049.467 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125049.467 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000742 sec.
 :20170228:125049.467 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125049.467 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.468 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.468 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125049.468 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.468 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.469 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125049.469 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.469 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.469 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[1] jobnet_abort_flag[0]
 :20170228:125049.469 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.469 [DEBUG] In jajobnet_summary_ready() inner_jobnet_id: 1500000000000000070
 :20170228:125049.469 [DEBUG] In ja_set_status_jobnet() inner_jobnet_id: 1500000000000000070, status: 1
 :20170228:125049.469 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125049.470 [DEBUG] query [txnlev:1] [update ja_run_jobnet_table set status = 1 , start_time = 0 , end_time = 0 where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.470 [DEBUG] In ja_set_status_jobnet_summary() inner_jobnet_id: 1500000000000000070, status: 2
 :20170228:125049.470 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_summary_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125049.470 [DEBUG] query [txnlev:1] [update ja_run_jobnet_summary_table set status = 2 , start_time = 20170228125049 , end_time = 0  where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.471 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.474 [DEBUG] End of process_jajobnet_summary()
 :20170228:125049.474 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125049.474 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000515 sec.
 :20170228:125049.474 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125049.474 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.475 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125049.475 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125049.475 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000314 sec.
 :20170228:125049.475 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125049.475 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.475 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125049.475 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.475 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125049.475 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125049.476 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000392 sec.
 :20170228:125049.476 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125049.476 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.476 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125049.476 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.476 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125049.476 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125049.477 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000357 sec.
 :20170228:125049.477 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125049.477 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.477 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[1]
 :20170228:125049.477 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125049.477 [DEBUG] In jajobnet_ready() inner_jobnet_id: 1500000000000000070
 :20170228:125049.477 [DEBUG] query [txnlev:1] [select jobnet_id, jobnet_name, user_name, inner_jobnet_id, main_flag, scheduled_time from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.478 [DEBUG] In ja_set_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.478 [DEBUG] query [txnlev:1] [insert into ja_value_before_jobnet_table (inner_jobnet_id, value_name, before_value) values (1500000000000000070, 'JOBNET_ID', 'JBN_SRV_041')]
 :20170228:125049.478 [DEBUG] In ja_set_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.478 [DEBUG] query [txnlev:1] [insert into ja_value_before_jobnet_table (inner_jobnet_id, value_name, before_value) values (1500000000000000070, 'JOBNET_NAME', 'Jenkins?o?b?N?A?b?v')]
 :20170228:125049.478 [DEBUG] In ja_set_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.478 [DEBUG] query [txnlev:1] [insert into ja_value_before_jobnet_table (inner_jobnet_id, value_name, before_value) values (1500000000000000070, 'USER_NAME', 'Admin')]
 :20170228:125049.479 [DEBUG] In ja_set_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.479 [DEBUG] query [txnlev:1] [insert into ja_value_before_jobnet_table (inner_jobnet_id, value_name, before_value) values (1500000000000000070, 'MANAGEMENT_ID', '1500000000000000070')]
 :20170228:125049.479 [DEBUG] In ja_set_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.479 [DEBUG] query [txnlev:1] [insert into ja_value_before_jobnet_table (inner_jobnet_id, value_name, before_value) values (1500000000000000070, 'JOBNET_BOOT_TIME', '201702281250')]
 :20170228:125049.479 [DEBUG] In ja_set_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.479 [DEBUG] query [txnlev:1] [insert into ja_value_before_jobnet_table (inner_jobnet_id, value_name, before_value) values (1500000000000000070, 'JOBNET_SCHEDULED_TIME', '')]
 :20170228:125049.480 [DEBUG] In ja_set_run_jobnet() inner_jobnet_id: 1500000000000000070
 :20170228:125049.480 [DEBUG] In ja_clean_value_jobnet_before() inner_jobnet_id: 1500000000000000070
 :20170228:125049.480 [DEBUG] query [txnlev:1] [select seq_no, value_name from ja_value_before_jobnet_table  where inner_jobnet_id = 1500000000000000070 order by value_name, seq_no desc]
 :20170228:125049.480 [DEBUG] In ja_joblog() message_id: JC00000001
 :20170228:125049.480 [DEBUG] query [txnlev:1] [insert into ja_run_log_table ( log_date, inner_jobnet_id, inner_jobnet_main_id, update_date, method_flag, jobnet_status, run_type, public_flag, jobnet_id, jobnet_name, user_name, message_id) select 20170228125049480, inner_jobnet_id, inner_jobnet_main_id, update_date, 0, status, run_type, public_flag, jobnet_id, jobnet_name, user_name, 'JC00000001' from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.480 [DEBUG] In ja_set_status_jobnet() inner_jobnet_id: 1500000000000000070, status: 2
 :20170228:125049.480 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125049.481 [DEBUG] query [txnlev:1] [update ja_run_jobnet_table set status = 2 , start_time = 20170228125049 , end_time = 0 where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.481 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_jobnet_id = 1500000000000000070 and job_type = 0 ]
 :20170228:125049.482 [DEBUG] In ja_value_before_jobnet_out() inner_jobnet_id: 1500000000000000070, inner_job_id: 556
 :20170228:125049.482 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) select 556, 1500000000000000070, value_name, before_value from ja_value_before_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125049.485 [DEBUG] In ja_set_status_job() inner_job_id: 556, status: 1
 :20170228:125049.485 [DEBUG] query [txnlev:1] [select status from ja_run_job_table where inner_job_id = 556 for update]
 :20170228:125049.485 [DEBUG] query [txnlev:1] [update ja_run_job_table set status = 1 , start_time = 0 , end_time = 0 where inner_job_id = 556]
 :20170228:125049.486 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125049.487 [DEBUG] In jobnet_load_immediate()
 :20170228:125049.487 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125049.488 [DEBUG] job loader #1 (immediate start) spent 0.000736 seconds while processing rules
 :20170228:125049.488 [DEBUG] sleeping for 1 seconds
 :20170228:125049.488 [DEBUG] End of process_jajobnet()
 :20170228:125049.488 [DEBUG] sleeping for 1 seconds
 :20170228:125050.402 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125050.402 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125050.402 [DEBUG] sleeping for 1 seconds
 :20170228:125050.430 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125050.430 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000585 sec.
 :20170228:125050.430 [DEBUG] End of process_jajob()
 :20170228:125050.430 [DEBUG] sleeping for 1 seconds
 :20170228:125050.433 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125050.434 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000721 sec.
 :20170228:125050.434 [DEBUG] In process_jarun() inner_job_id: 556, inner_jobnet_id: 1500000000000000070, method_flag: 0, job_type: 0, test_flag: 0
 :20170228:125050.434 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.435 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 556 and status = 1 for update]
 :20170228:125050.435 [DEBUG] In ja_joblog() message_id: JC00000003
 :20170228:125050.435 [DEBUG] query [txnlev:1] [insert into ja_run_log_table ( log_date, inner_jobnet_id, inner_jobnet_main_id, inner_job_id, update_date, method_flag, jobnet_status, job_status, run_type, public_flag, jobnet_id, jobnet_name, job_id, job_name, user_name, message_id) select 20170228125050435, a.inner_jobnet_id, a.inner_jobnet_main_id, b.inner_job_id, a.update_date, b.method_flag, a.status, b.status, a.run_type, a.public_flag, a.jobnet_id, a.jobnet_name, b.job_id, b.job_name, a.user_name, 'JC00000003' from ja_run_jobnet_table a, ja_run_job_table b where a.inner_jobnet_id = b.inner_jobnet_id and b.inner_job_id = 556 and b.inner_jobnet_id = 1500000000000000070]
 :20170228:125050.437 [DEBUG] In jarun_normal() inner_job_id: 556, job_type: 0, test_flag: 0
 :20170228:125050.437 [DEBUG] In jarun_value_before() inner_job_id: 556
 :20170228:125050.437 [DEBUG] query [txnlev:1] [select inner_jobnet_id, job_id, job_name from ja_run_job_table where inner_job_id = 556]
 :20170228:125050.437 [DEBUG] In ja_set_value_before() inner_job_id: 556, inner_jobnet_id: 1500000000000000070
 :20170228:125050.438 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (556, 1500000000000000070, 'JOB_ID', 'START')]
 :20170228:125050.438 [DEBUG] In ja_set_value_before() inner_job_id: 556, inner_jobnet_id: 1500000000000000070
 :20170228:125050.438 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (556, 1500000000000000070, 'JOB_NAME', '')]
 :20170228:125050.439 [DEBUG] In ja_set_value_before() inner_job_id: 556, inner_jobnet_id: 1500000000000000070
 :20170228:125050.439 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (556, 1500000000000000070, 'CURRENT_TIME', '20170228125050')]
 :20170228:125050.439 [DEBUG] In ja_get_jobid() inner_job_id: 556
 :20170228:125050.439 [DEBUG] query [txnlev:1] [select inner_jobnet_id, inner_jobnet_main_id, job_id from ja_run_job_table where inner_job_id = 556]
 :20170228:125050.440 [DEBUG] query [txnlev:1] [select jobnet_id from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125050.440 [DEBUG] In ja_set_value_before() inner_job_id: 556, inner_jobnet_id: 1500000000000000070
 :20170228:125050.440 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (556, 1500000000000000070, 'JOB_ID_FULL', 'JBN_SRV_041/START')]
 :20170228:125050.441 [DEBUG] In ja_remove_value_before() inner_job_id: 556
 :20170228:125050.441 [DEBUG] query [txnlev:1] [delete from ja_run_value_before_table  where inner_job_id = 556 and value_name = 'JOBARG_MESSAGE']
 :20170228:125050.442 [DEBUG] In ja_set_run() inner_job_id: 556
 :20170228:125050.442 [DEBUG] In ja_clean_value_before() inner_job_id: 556
 :20170228:125050.442 [DEBUG] query [txnlev:1] [select seq_no, value_name from ja_run_value_before_table  where inner_job_id = 556 order by value_name, seq_no desc]
 :20170228:125050.443 [DEBUG] In ja_set_status_job() inner_job_id: 556, status: 2
 :20170228:125050.443 [DEBUG] query [txnlev:1] [select status from ja_run_job_table where inner_job_id = 556 for update]
 :20170228:125050.443 [DEBUG] query [txnlev:1] [update ja_run_job_table set status = 2 , start_time = 20170228125050 , end_time = 0 where inner_job_id = 556]
 :20170228:125050.444 [DEBUG] In ja_set_run_job_id() inner_job_id: 556
 :20170228:125050.444 [DEBUG] query [txnlev:1] [select inner_jobnet_main_id, job_name from ja_run_job_table where inner_job_id = 556]
 :20170228:125050.444 [DEBUG] In ja_get_jobid() inner_job_id: 556
 :20170228:125050.444 [DEBUG] query [txnlev:1] [select inner_jobnet_id, inner_jobnet_main_id, job_id from ja_run_job_table where inner_job_id = 556]
 :20170228:125050.446 [DEBUG] query [txnlev:1] [select jobnet_id from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125050.446 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_summary_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125050.447 [DEBUG] query [txnlev:1] [update ja_run_jobnet_summary_table set running_job_id = 'JBN_SRV_041/START', running_job_name = '' where inner_jobnet_id  = 1500000000000000070]
 :20170228:125050.447 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125050.448 [DEBUG] query [txnlev:1] [update ja_run_jobnet_table set running_job_id = 'JBN_SRV_041/START', running_job_name = '' where inner_jobnet_id  = 1500000000000000070]
 :20170228:125050.448 [DEBUG] In ja_value_before_after() inner_job_id: 556
 :20170228:125050.448 [DEBUG] query [txnlev:1] [insert into ja_run_value_after_table (inner_job_id, inner_jobnet_id, value_name, after_value) select inner_job_id, inner_jobnet_id, value_name, before_value from ja_run_value_before_table where inner_job_id = 556]
 :20170228:125050.449 [DEBUG] In message_purge()
 :20170228:125050.449 [DEBUG] In get_purge_date(1440)
 :20170228:125050.449 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.450 [DEBUG] In jarun_icon_start() inner_job_id: 556
 :20170228:125050.450 [DEBUG] In ja_flow() inner_job_id: 556, type: 0
 :20170228:125050.450 [DEBUG] In ja_clean_value_after() inner_job_id: 556
 :20170228:125050.450 [DEBUG] query [txnlev:1] [select seq_no, value_name from ja_run_value_after_table  where inner_job_id = 556 order by value_name, seq_no desc]
 :20170228:125050.450 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125050.451 [DEBUG] In get_purge_date(60)
 :20170228:125050.451 [DEBUG] In get_purge_date(43200)
 :20170228:125050.451 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125050.451 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125050.452 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.452 [DEBUG] query [txnlev:1] [select inner_jobnet_id, end_inner_job_id, flow_type from ja_run_flow_table where start_inner_job_id = 556]
 :20170228:125050.452 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.001162 seconds while processing rules
 :20170228:125050.452 [DEBUG] In joblog_purge(201701291250)
 :20170228:125050.452 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125050.456 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.456 [DEBUG] In ja_flow() start_inner_job_id: 556, end_inner_job_id: 550, flow_type: 0,  type: 0
 :20170228:125050.456 [DEBUG] In ja_get_status_jobnet() inner_jobnet_id: 1500000000000000070
 :20170228:125050.456 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125050.456 [DEBUG] jobnet boot #1 (joblog purge) spent 0.004555 seconds while processing rules
 :20170228:125050.457 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125050.457 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125050.458 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125050.458 [DEBUG] In ja_flow_set_status() start_inner_job_id: 556, end_inner_job_id: 550
 :20170228:125050.458 [DEBUG] query [txnlev:1] [select status, test_flag, job_type, boot_count, end_count from ja_run_job_table  where inner_job_id = 550 for update]
 :20170228:125050.458 [DEBUG] jobnet boot #1 (jobnet start) spent 0.001515 seconds while processing rules
 :20170228:125050.458 [DEBUG] sleeping for 1 seconds
 :20170228:125050.459 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.459 [DEBUG] query [txnlev:1] [update ja_run_job_table set status = 1, end_count = 1 where inner_job_id = 550]
 :20170228:125050.460 [DEBUG] message send #1 (message purge) spent 0.010885 seconds while processing rules
 :20170228:125050.460 [DEBUG] In message_send()
 :20170228:125050.460 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125050 order by retry_date, message_date]
 :20170228:125050.461 [DEBUG] In ja_value_after_before() inner_job_id: 556, next_inner_job_id: 550
 :20170228:125050.461 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) select 550, inner_jobnet_id, value_name, after_value from ja_run_value_after_table where inner_job_id = 556]
 :20170228:125050.461 [DEBUG] message send #1 (message send) spent 0.001434 seconds while processing rules
 :20170228:125050.461 [DEBUG] sleeping for 1 seconds
 :20170228:125050.462 [DEBUG] In ja_set_end() inner_job_id: 556 msg_flag: 1
 :20170228:125050.462 [DEBUG] In ja_clean_value_after() inner_job_id: 556
 :20170228:125050.462 [DEBUG] query [txnlev:1] [select seq_no, value_name from ja_run_value_after_table  where inner_job_id = 556 order by value_name, seq_no desc]
 :20170228:125050.463 [DEBUG] In ja_joblog() message_id: JC00000004
 :20170228:125050.463 [DEBUG] query [txnlev:1] [select inner_jobnet_id from ja_run_job_table where inner_job_id = 556]
 :20170228:125050.463 [DEBUG] query [txnlev:1] [select job_type from ja_run_job_table where inner_job_id = 556]
 :20170228:125050.463 [DEBUG] query [txnlev:1] [insert into ja_run_log_table ( log_date, inner_jobnet_id, inner_jobnet_main_id, inner_job_id, update_date, method_flag, jobnet_status, job_status, run_type, public_flag, jobnet_id, jobnet_name, job_id, job_name, user_name, message_id) select 20170228125050463, a.inner_jobnet_id, a.inner_jobnet_main_id, b.inner_job_id, a.update_date, b.method_flag, a.status, b.status, a.run_type, a.public_flag, a.jobnet_id, a.jobnet_name, b.job_id, b.job_name, a.user_name, 'JC00000004' from ja_run_jobnet_table a, ja_run_job_table b where a.inner_jobnet_id = b.inner_jobnet_id and b.inner_job_id = 556 and b.inner_jobnet_id = 1500000000000000070]
 :20170228:125050.464 [DEBUG] In ja_set_status_job() inner_job_id: 556, status: 3
 :20170228:125050.464 [DEBUG] query [txnlev:1] [select status from ja_run_job_table where inner_job_id = 556 for update]
 :20170228:125050.464 [DEBUG] query [txnlev:1] [update ja_run_job_table set status = 3  , end_time = 20170228125050 where inner_job_id = 556]
 :20170228:125050.464 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.467 [DEBUG] End of process_jarun()
 :20170228:125050.467 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125050.467 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000497 sec.
 :20170228:125050.467 [DEBUG] In process_jarun() inner_job_id: 550, inner_jobnet_id: 1500000000000000070, method_flag: 0, job_type: 4, test_flag: 0
 :20170228:125050.468 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.468 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 550 and status = 1 for update]
 :20170228:125050.468 [DEBUG] In ja_joblog() message_id: JC00000003
 :20170228:125050.468 [DEBUG] query [txnlev:1] [insert into ja_run_log_table ( log_date, inner_jobnet_id, inner_jobnet_main_id, inner_job_id, update_date, method_flag, jobnet_status, job_status, run_type, public_flag, jobnet_id, jobnet_name, job_id, job_name, user_name, message_id) select 20170228125050468, a.inner_jobnet_id, a.inner_jobnet_main_id, b.inner_job_id, a.update_date, b.method_flag, a.status, b.status, a.run_type, a.public_flag, a.jobnet_id, a.jobnet_name, b.job_id, b.job_name, a.user_name, 'JC00000003' from ja_run_jobnet_table a, ja_run_job_table b where a.inner_jobnet_id = b.inner_jobnet_id and b.inner_job_id = 550 and b.inner_jobnet_id = 1500000000000000070]
 :20170228:125050.469 [DEBUG] In jarun_normal() inner_job_id: 550, job_type: 4, test_flag: 0
 :20170228:125050.469 [DEBUG] In jarun_value_before() inner_job_id: 550
 :20170228:125050.469 [DEBUG] query [txnlev:1] [select inner_jobnet_id, job_id, job_name from ja_run_job_table where inner_job_id = 550]
 :20170228:125050.469 [DEBUG] In ja_set_value_before() inner_job_id: 550, inner_jobnet_id: 1500000000000000070
 :20170228:125050.469 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (550, 1500000000000000070, 'JOB_ID', 'JB_SRV_041_001')]
 :20170228:125050.470 [DEBUG] In ja_set_value_before() inner_job_id: 550, inner_jobnet_id: 1500000000000000070
 :20170228:125050.470 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (550, 1500000000000000070, 'JOB_NAME', 'Jenkins?ݒ???o?b?N?A?b?v???s??')]
 :20170228:125050.470 [DEBUG] In ja_set_value_before() inner_job_id: 550, inner_jobnet_id: 1500000000000000070
 :20170228:125050.470 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (550, 1500000000000000070, 'CURRENT_TIME', '20170228125050')]
 :20170228:125050.470 [DEBUG] In ja_get_jobid() inner_job_id: 550
 :20170228:125050.470 [DEBUG] query [txnlev:1] [select inner_jobnet_id, inner_jobnet_main_id, job_id from ja_run_job_table where inner_job_id = 550]
 :20170228:125050.471 [DEBUG] query [txnlev:1] [select jobnet_id from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125050.471 [DEBUG] In ja_set_value_before() inner_job_id: 550, inner_jobnet_id: 1500000000000000070
 :20170228:125050.471 [DEBUG] query [txnlev:1] [insert into ja_run_value_before_table (inner_job_id, inner_jobnet_id, value_name, before_value) values (550, 1500000000000000070, 'JOB_ID_FULL', 'JBN_SRV_041/JB_SRV_041_001')]
 :20170228:125050.471 [DEBUG] In ja_remove_value_before() inner_job_id: 550
 :20170228:125050.471 [DEBUG] query [txnlev:1] [delete from ja_run_value_before_table  where inner_job_id = 550 and value_name = 'JOBARG_MESSAGE']
 :20170228:125050.472 [DEBUG] In ja_set_run() inner_job_id: 550
 :20170228:125050.472 [DEBUG] In ja_clean_value_before() inner_job_id: 550
 :20170228:125050.472 [DEBUG] query [txnlev:1] [select seq_no, value_name from ja_run_value_before_table  where inner_job_id = 550 order by value_name, seq_no desc]
 :20170228:125050.472 [DEBUG] query [txnlev:1] [delete from ja_run_value_before_table where seq_no = 4010]
 :20170228:125050.472 [DEBUG] query [txnlev:1] [delete from ja_run_value_before_table where seq_no = 4008]
 :20170228:125050.473 [DEBUG] query [txnlev:1] [delete from ja_run_value_before_table where seq_no = 4011]
 :20170228:125050.473 [DEBUG] query [txnlev:1] [delete from ja_run_value_before_table where seq_no = 4009]
 :20170228:125050.473 [DEBUG] In ja_set_status_job() inner_job_id: 550, status: 2
 :20170228:125050.473 [DEBUG] query [txnlev:1] [select status from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125050.474 [DEBUG] query [txnlev:1] [update ja_run_job_table set status = 2 , start_time = 20170228125050 , end_time = 0 where inner_job_id = 550]
 :20170228:125050.474 [DEBUG] In ja_set_run_job_id() inner_job_id: 550
 :20170228:125050.474 [DEBUG] query [txnlev:1] [select inner_jobnet_main_id, job_name from ja_run_job_table where inner_job_id = 550]
 :20170228:125050.475 [DEBUG] In ja_get_jobid() inner_job_id: 550
 :20170228:125050.475 [DEBUG] query [txnlev:1] [select inner_jobnet_id, inner_jobnet_main_id, job_id from ja_run_job_table where inner_job_id = 550]
 :20170228:125050.475 [DEBUG] query [txnlev:1] [select jobnet_id from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125050.476 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_summary_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125050.476 [DEBUG] query [txnlev:1] [update ja_run_jobnet_summary_table set running_job_id = 'JBN_SRV_041/JB_SRV_041_001', running_job_name = 'Jenkins?ݒ???o?b?N?A?b?v???s??' where inner_jobnet_id  = 1500000000000000070]
 :20170228:125050.476 [DEBUG] query [txnlev:1] [select status from ja_run_jobnet_table where inner_jobnet_id = 1500000000000000070 for update]
 :20170228:125050.477 [DEBUG] query [txnlev:1] [update ja_run_jobnet_table set running_job_id = 'JBN_SRV_041/JB_SRV_041_001', running_job_name = 'Jenkins?ݒ???o?b?N?A?b?v???s??' where inner_jobnet_id  = 1500000000000000070]
 :20170228:125050.477 [DEBUG] In ja_value_before_after() inner_job_id: 550
 :20170228:125050.477 [DEBUG] query [txnlev:1] [insert into ja_run_value_after_table (inner_job_id, inner_jobnet_id, value_name, after_value) select inner_job_id, inner_jobnet_id, value_name, before_value from ja_run_value_before_table where inner_job_id = 550]
 :20170228:125050.478 [DEBUG] In jarun_icon_job() inner_job_id: 550
 :20170228:125050.478 [DEBUG] In ja_job_object_init()
 :20170228:125050.478 [DEBUG] query [txnlev:1] [select inner_jobnet_id, host_flag, command_type, host_name from ja_run_icon_job_table where inner_job_id = 550]
 :20170228:125050.478 [DEBUG] In ja_host_getname() host_flag: 0, host_name: ci01,
 :20170228:125050.478 [DEBUG] In ja_host_lockinfo() host: ci01
 :20170228:125050.478 [DEBUG] query [txnlev:1] [select lock_host_name from ja_host_lock_table where lock_host_name = 'ci01']
 :20170228:125050.479 [DEBUG] query [txnlev:1] [select command from ja_run_job_command_table where inner_job_id = 550 and command_cls = 0]
 :20170228:125050.479 [DEBUG] query [txnlev:1] [select run_user,run_user_password from ja_run_job_table where inner_job_id = 550]
 :20170228:125050.479 [DEBUG] In jarun_icon_job_getenv() inner_job_id: 550
 :20170228:125050.479 [DEBUG] query [txnlev:1] [select value_name from ja_run_value_jobcon_table where inner_job_id = 550]
 :20170228:125050.480 [DEBUG] query [txnlev:1] [select value_name, value from ja_run_value_job_table where inner_job_id = 550]
 :20170228:125050.481 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.481 [DEBUG] In ja_job_object_init()
 :20170228:125050.481 [DEBUG] In DBconnect() flag:2
 :20170228:125050.483 [DEBUG] query [txnlev:1] [set names utf8]
 :20170228:125050.484 [DEBUG] End of process_jarun()
 :20170228:125050.484 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125050.484 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000255 sec.
 :20170228:125050.484 [DEBUG] End of process_jarun()
 :20170228:125050.484 [DEBUG] sleeping for 1 seconds
 :20170228:125050.484 [DEBUG] End of DBconnect():0
 :20170228:125050.484 [DEBUG] In ja_connect() host: ci01
 :20170228:125050.485 [DEBUG] In ja_host_getip() host: ci01
 :20170228:125050.485 [DEBUG] query [txnlev:1] [ select i.hostid, i.useip, i.dns, i.ip, h.status, i.port from hosts h, interface i where h.hostid = i.hostid and i.main = 1 and h.host = 'ci01']
 :20170228:125050.485 [DEBUG] query [txnlev:1] [select force_flag, job_id from ja_run_job_table where inner_job_id = 550]
 :20170228:125050.485 [DEBUG] In ja_host_getport() hostid: 10105
 :20170228:125050.485 [DEBUG] query [txnlev:1] [select value from hostmacro where hostid = 10105 and macro = '{$JOBARRANGER_AGENT_PORT}']
 :20170228:125050.486 [DEBUG] In ja_connect() connect the host. source_ip: 192.168.33.11, host_ip: 192.168.33.23, port: 10055, timeout: 4
 :20170228:125050.486 [DEBUG] In ja_tcp_send_to()
 :20170228:125050.486 [DEBUG] In ja_telegram_to()
 :20170228:125050.486 [DEBUG] In ja_telegram_to_head()
 :20170228:125050.486 [DEBUG] In ja_telegram_to_request()
 :20170228:125050.486 [DEBUG] In ja_tcp_send_to() { "kind": "jobrun", "version": 1, "serverid": "20170228125045382", "hostname": "ci01", "data": { "jobid": "550", "type": "command", "method": 0, "script": "set -o pipefail\r\n\/amida\/sh\/jenkins-backup.sh \/var\/lib\/jenkins \/amida\/backup\/jenkins\/jenkins_backup_`date +\"%Y%m%d%H%M%S\"`.tar.gz 2>&1 | tee -a \/amida\/logs\/sh\/jenkins-backup.sh-`date +%Y%m%d%H%M%S`.log", "argument": { }, "env": { }, "run_user": "", "run_user_password": "" } }
 :20170228:125050.486 [DEBUG] In ja_tcp_recv_to()
 :20170228:125050.488 [DEBUG] In jobnet_load_immediate()
 :20170228:125050.488 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125050.489 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125050.489 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000766 sec.
 :20170228:125050.489 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125050.489 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.490 [DEBUG] job loader #1 (immediate start) spent 0.001270 seconds while processing rules
 :20170228:125050.490 [DEBUG] sleeping for 1 seconds
 :20170228:125050.490 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.490 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125050.490 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.490 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.491 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125050.491 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.491 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.491 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125050.491 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.491 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.491 [DEBUG] End of process_jajobnet_summary()
 :20170228:125050.491 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125050.492 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000361 sec.
 :20170228:125050.492 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125050.492 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.492 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125050.492 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125050.492 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000353 sec.
 :20170228:125050.492 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125050.492 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.493 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125050.493 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.493 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125050.493 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125050.493 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000345 sec.
 :20170228:125050.493 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125050.493 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.493 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125050.493 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.494 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125050.494 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125050.494 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000393 sec.
 :20170228:125050.494 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125050.494 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.494 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[2]
 :20170228:125050.494 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125050.495 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, icon_jobnet_id: 0, status: 2, timeout_flag: 0
 :20170228:125050.495 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125050.495 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000070) 0.000277 sec.
 :20170228:125050.495 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 1, runerr: 0, end: 1, timeout: 0
 :20170228:125050.495 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125050.495 [DEBUG] End of process_jajobnet()
 :20170228:125050.495 [DEBUG] sleeping for 1 seconds
 :20170228:125050.510 [DEBUG] In ja_tcp_recv_to() { "kind": "jobrun-res", "version": 1, "serverid": "20170228125045382", "hostname": "ci01", "data": { "result": 0 } }
 :20170228:125050.510 [DEBUG] In ja_telegram_from() telegram: { "kind": "jobrun-res", "version": 1, "serverid": "20170228125045382", "hostname": "ci01", "data": { "result": 0 } }
 :20170228:125050.510 [DEBUG] In ja_telegram_from_head() telegram: { "kind": "jobrun-res", "version": 1, "serverid": "20170228125045382", "hostname": "ci01", "data": { "result": 0 } }
 :20170228:125050.510 [DEBUG] In ja_telegram_from_response()
 :20170228:125050.511 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125050.511 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000576 sec.
 :20170228:125050.511 [DEBUG] End of process_jarun()
 :20170228:125050.512 [DEBUG] sleeping for 1 seconds
 :20170228:125051.403 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125051.403 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125051.403 [DEBUG] sleeping for 1 seconds
 :20170228:125051.431 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125051.431 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000611 sec.
 :20170228:125051.431 [DEBUG] inner_job_id: 550, method_flag: 0, job_type: 4
 :20170228:125051.431 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.431 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125051.432 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.432 [DEBUG] End of process_jajob()
 :20170228:125051.432 [DEBUG] sleeping for 1 seconds
 :20170228:125051.459 [DEBUG] In get_purge_date(60)
 :20170228:125051.459 [DEBUG] In get_purge_date(43200)
 :20170228:125051.459 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125051.459 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125051.460 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000400 seconds while processing rules
 :20170228:125051.460 [DEBUG] In joblog_purge(201701291250)
 :20170228:125051.460 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125051.460 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000529 seconds while processing rules
 :20170228:125051.460 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125051.460 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125051.461 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000403 seconds while processing rules
 :20170228:125051.461 [DEBUG] sleeping for 1 seconds
 :20170228:125051.462 [DEBUG] In message_purge()
 :20170228:125051.462 [DEBUG] In get_purge_date(1440)
 :20170228:125051.462 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.462 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125051.463 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.463 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.463 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125051.463 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.464 [DEBUG] message send #1 (message purge) spent 0.001779 seconds while processing rules
 :20170228:125051.464 [DEBUG] In message_send()
 :20170228:125051.464 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125051 order by retry_date, message_date]
 :20170228:125051.464 [DEBUG] message send #1 (message send) spent 0.000358 seconds while processing rules
 :20170228:125051.464 [DEBUG] sleeping for 1 seconds
 :20170228:125051.490 [DEBUG] In jobnet_load_immediate()
 :20170228:125051.490 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125051.491 [DEBUG] job loader #1 (immediate start) spent 0.000698 seconds while processing rules
 :20170228:125051.491 [DEBUG] sleeping for 1 seconds
 :20170228:125051.495 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125051.496 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000859 sec.
 :20170228:125051.496 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125051.496 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.496 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.497 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125051.497 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.497 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.497 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125051.497 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.498 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.498 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125051.498 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.499 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.499 [DEBUG] End of process_jajobnet_summary()
 :20170228:125051.499 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125051.500 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000670 sec.
 :20170228:125051.500 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125051.500 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.500 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125051.500 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125051.500 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000372 sec.
 :20170228:125051.500 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125051.500 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.501 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125051.501 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.501 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125051.501 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125051.501 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000319 sec.
 :20170228:125051.501 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125051.501 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.502 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125051.502 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.502 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125051.502 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125051.502 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000511 sec.
 :20170228:125051.502 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125051.502 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.503 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[2]
 :20170228:125051.503 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125051.503 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, icon_jobnet_id: 0, status: 2, timeout_flag: 0
 :20170228:125051.503 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125051.504 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000070) 0.000402 sec.
 :20170228:125051.504 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 1, runerr: 0, end: 1, timeout: 0
 :20170228:125051.504 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125051.504 [DEBUG] End of process_jajobnet()
 :20170228:125051.504 [DEBUG] sleeping for 1 seconds
 :20170228:125051.512 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125051.512 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000719 sec.
 :20170228:125051.513 [DEBUG] End of process_jarun()
 :20170228:125051.513 [DEBUG] sleeping for 1 seconds
 :20170228:125052.404 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125052.404 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125052.404 [DEBUG] sleeping for 1 seconds
 :20170228:125052.433 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125052.433 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000493 sec.
 :20170228:125052.433 [DEBUG] inner_job_id: 550, method_flag: 0, job_type: 4
 :20170228:125052.433 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.433 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125052.433 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.434 [DEBUG] End of process_jajob()
 :20170228:125052.434 [DEBUG] sleeping for 1 seconds
 :20170228:125052.461 [DEBUG] In get_purge_date(60)
 :20170228:125052.461 [DEBUG] In get_purge_date(43200)
 :20170228:125052.461 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125052.461 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125052.462 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000739 seconds while processing rules
 :20170228:125052.462 [DEBUG] In joblog_purge(201701291250)
 :20170228:125052.462 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125052.462 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000346 seconds while processing rules
 :20170228:125052.462 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125052.462 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125052.463 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000670 seconds while processing rules
 :20170228:125052.463 [DEBUG] sleeping for 1 seconds
 :20170228:125052.465 [DEBUG] In message_purge()
 :20170228:125052.465 [DEBUG] In get_purge_date(1440)
 :20170228:125052.465 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.465 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125052.466 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.466 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.466 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125052.466 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.467 [DEBUG] message send #1 (message purge) spent 0.001846 seconds while processing rules
 :20170228:125052.467 [DEBUG] In message_send()
 :20170228:125052.467 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125052 order by retry_date, message_date]
 :20170228:125052.467 [DEBUG] message send #1 (message send) spent 0.000398 seconds while processing rules
 :20170228:125052.467 [DEBUG] sleeping for 1 seconds
 :20170228:125052.491 [DEBUG] In jobnet_load_immediate()
 :20170228:125052.491 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125052.492 [DEBUG] job loader #1 (immediate start) spent 0.000821 seconds while processing rules
 :20170228:125052.492 [DEBUG] sleeping for 1 seconds
 :20170228:125052.505 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125052.506 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000652 sec.
 :20170228:125052.506 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125052.506 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.506 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.506 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125052.506 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.506 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.507 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125052.507 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.507 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.507 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125052.507 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.507 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.508 [DEBUG] End of process_jajobnet_summary()
 :20170228:125052.508 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125052.508 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000343 sec.
 :20170228:125052.508 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125052.508 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.508 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125052.508 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125052.509 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000515 sec.
 :20170228:125052.509 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125052.509 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.509 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125052.509 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.510 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125052.510 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125052.510 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000357 sec.
 :20170228:125052.510 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125052.510 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.510 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125052.510 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.510 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125052.510 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125052.511 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000411 sec.
 :20170228:125052.511 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125052.511 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.511 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[2]
 :20170228:125052.511 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125052.512 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, icon_jobnet_id: 0, status: 2, timeout_flag: 0
 :20170228:125052.512 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125052.512 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000070) 0.000324 sec.
 :20170228:125052.512 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 1, runerr: 0, end: 1, timeout: 0
 :20170228:125052.512 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125052.512 [DEBUG] End of process_jajobnet()
 :20170228:125052.512 [DEBUG] sleeping for 1 seconds
 :20170228:125052.514 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125052.514 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000299 sec.
 :20170228:125052.514 [DEBUG] End of process_jarun()
 :20170228:125052.514 [DEBUG] sleeping for 1 seconds
 :20170228:125053.405 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125053.405 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125053.405 [DEBUG] sleeping for 1 seconds
 :20170228:125053.435 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125053.435 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000576 sec.
 :20170228:125053.435 [DEBUG] inner_job_id: 550, method_flag: 0, job_type: 4
 :20170228:125053.435 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.436 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125053.436 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.436 [DEBUG] End of process_jajob()
 :20170228:125053.436 [DEBUG] sleeping for 1 seconds
 :20170228:125053.464 [DEBUG] In get_purge_date(60)
 :20170228:125053.464 [DEBUG] In get_purge_date(43200)
 :20170228:125053.464 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125053.464 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125053.465 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000412 seconds while processing rules
 :20170228:125053.465 [DEBUG] In joblog_purge(201701291250)
 :20170228:125053.465 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125053.465 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000477 seconds while processing rules
 :20170228:125053.465 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125053.465 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125053.465 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000335 seconds while processing rules
 :20170228:125053.465 [DEBUG] sleeping for 1 seconds
 :20170228:125053.468 [DEBUG] In message_purge()
 :20170228:125053.468 [DEBUG] In get_purge_date(1440)
 :20170228:125053.468 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.468 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125053.468 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.469 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.469 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125053.470 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.470 [DEBUG] message send #1 (message purge) spent 0.001954 seconds while processing rules
 :20170228:125053.470 [DEBUG] In message_send()
 :20170228:125053.470 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125053 order by retry_date, message_date]
 :20170228:125053.470 [DEBUG] message send #1 (message send) spent 0.000437 seconds while processing rules
 :20170228:125053.470 [DEBUG] sleeping for 1 seconds
 :20170228:125053.492 [DEBUG] In jobnet_load_immediate()
 :20170228:125053.492 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125053.493 [DEBUG] job loader #1 (immediate start) spent 0.000750 seconds while processing rules
 :20170228:125053.493 [DEBUG] sleeping for 1 seconds
 :20170228:125053.513 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125053.514 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000678 sec.
 :20170228:125053.514 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125053.514 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.514 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.514 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125053.515 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000448 sec.
 :20170228:125053.515 [DEBUG] End of process_jarun()
 :20170228:125053.515 [DEBUG] sleeping for 1 seconds
 :20170228:125053.515 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125053.515 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.515 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.515 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125053.515 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.515 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.516 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125053.516 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.516 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.516 [DEBUG] End of process_jajobnet_summary()
 :20170228:125053.516 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125053.516 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000267 sec.
 :20170228:125053.516 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125053.516 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.516 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125053.516 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125053.517 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000636 sec.
 :20170228:125053.517 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125053.517 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.517 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125053.517 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.518 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125053.518 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125053.518 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000245 sec.
 :20170228:125053.518 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125053.518 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.518 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125053.518 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.518 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125053.518 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125053.519 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000365 sec.
 :20170228:125053.519 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125053.519 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.519 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[2]
 :20170228:125053.519 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125053.519 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, icon_jobnet_id: 0, status: 2, timeout_flag: 0
 :20170228:125053.519 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125053.519 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000070) 0.000236 sec.
 :20170228:125053.519 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 1, runerr: 0, end: 1, timeout: 0
 :20170228:125053.519 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125053.520 [DEBUG] End of process_jajobnet()
 :20170228:125053.520 [DEBUG] sleeping for 1 seconds
 :20170228:125054.406 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125054.406 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125054.406 [DEBUG] sleeping for 1 seconds
 :20170228:125054.437 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125054.437 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000479 sec.
 :20170228:125054.437 [DEBUG] inner_job_id: 550, method_flag: 0, job_type: 4
 :20170228:125054.437 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.437 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125054.437 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.438 [DEBUG] End of process_jajob()
 :20170228:125054.438 [DEBUG] sleeping for 1 seconds
 :20170228:125054.466 [DEBUG] In get_purge_date(60)
 :20170228:125054.466 [DEBUG] In get_purge_date(43200)
 :20170228:125054.466 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125054.466 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125054.467 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000726 seconds while processing rules
 :20170228:125054.467 [DEBUG] In joblog_purge(201701291250)
 :20170228:125054.467 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125054.467 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000353 seconds while processing rules
 :20170228:125054.467 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125054.467 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125054.468 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000590 seconds while processing rules
 :20170228:125054.468 [DEBUG] sleeping for 1 seconds
 :20170228:125054.471 [DEBUG] In message_purge()
 :20170228:125054.471 [DEBUG] In get_purge_date(1440)
 :20170228:125054.471 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.471 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125054.472 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.472 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.472 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125054.473 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.473 [DEBUG] message send #1 (message purge) spent 0.002150 seconds while processing rules
 :20170228:125054.473 [DEBUG] In message_send()
 :20170228:125054.473 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125054 order by retry_date, message_date]
 :20170228:125054.473 [DEBUG] message send #1 (message send) spent 0.000395 seconds while processing rules
 :20170228:125054.473 [DEBUG] sleeping for 1 seconds
 :20170228:125054.493 [DEBUG] In jobnet_load_immediate()
 :20170228:125054.493 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125054.494 [DEBUG] job loader #1 (immediate start) spent 0.000897 seconds while processing rules
 :20170228:125054.494 [DEBUG] sleeping for 1 seconds
 :20170228:125054.515 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125054.516 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000634 sec.
 :20170228:125054.516 [DEBUG] End of process_jarun()
 :20170228:125054.516 [DEBUG] sleeping for 1 seconds
 :20170228:125054.521 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125054.521 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000655 sec.
 :20170228:125054.521 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125054.521 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.522 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.522 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125054.522 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.522 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.522 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125054.522 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.522 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.523 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125054.523 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.523 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.523 [DEBUG] End of process_jajobnet_summary()
 :20170228:125054.523 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125054.523 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000361 sec.
 :20170228:125054.523 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125054.524 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.525 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125054.525 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125054.526 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000782 sec.
 :20170228:125054.526 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125054.526 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.526 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125054.526 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.527 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125054.527 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125054.527 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000259 sec.
 :20170228:125054.527 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125054.527 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.527 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125054.527 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.527 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125054.527 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125054.528 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000350 sec.
 :20170228:125054.528 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125054.528 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.528 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[2]
 :20170228:125054.528 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125054.528 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, icon_jobnet_id: 0, status: 2, timeout_flag: 0
 :20170228:125054.528 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125054.529 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000070) 0.000588 sec.
 :20170228:125054.529 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 1, runerr: 0, end: 1, timeout: 0
 :20170228:125054.529 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125054.529 [DEBUG] End of process_jajobnet()
 :20170228:125054.529 [DEBUG] sleeping for 1 seconds
 :20170228:125055.313 [DEBUG] In process_jatrapper()
 :20170228:125055.313 [DEBUG] In ja_telegram_new()
 :20170228:125055.313 [DEBUG] In ja_telegram_recv()
 :20170228:125055.315 [DEBUG] In ja_telegram_recv() data: { "kind": "jobresult", "version": 1, "serverid": "20170228125045382", "hostname": "ci01", "data": { "jobid": "550", "hostname": "ci01", "method": 0, "result": 0, "std_out": "+ readonly JENKINS_HOME=\/var\/lib\/jenkins\n+ JENKINS_HOME=\/var\/lib\/jenkins\n+ readonly DEST_FILE=\/amida\/backup\/jenkins\/jenkins_backup_20170228125052.tar.gz\n+ DEST_FILE=\/amida\/backup\/jenkins\/jenkins_backup_20170228125052.tar.gz\n+++ dirname \/amida\/sh\/jenkins-backup.sh\n++ cd \/amida\/sh\n++ pwd\n+ readonly CUR_DIR=\/amida\/sh\n+ CUR_DIR=\/amida\/sh\n+ readonly TMP_DIR=\/amida\/sh\/tmp\n+ TMP_DIR=\/amida\/sh\/tmp\n+ readonly ARC_NAME=jenkins-backup\n+ ARC_NAME=jenkins-backup\n+ readonly ARC_DIR=\/amida\/sh\/tmp\/jenkins-backup\n+ ARC_DIR=\/amida\/sh\/tmp\/jenkins-backup\n+ readonly TMP_TAR_NAME=\/amida\/sh\/tmp\/archive.tar.gz\n+ TMP_TAR_NAME=\/amida\/sh\/tmp\/archive.tar.gz\n+ '[' -z \/var\/lib\/jenkins -o -z \/amida\/backup\/jenkins\/jenkins_backup_20170228125052.tar.gz ']'\n+ rm -rf \/amida\/sh\/tmp\/jenkins-backup \/amida\/sh\/tmp\/archive.tar.gz\n+ for i in plugins jobs users secrets nodes\n+ mkdir -p \/amida\/sh\/tmp\/jenkins-backup\/plugins\n+ for i in plugins jobs users secrets nodes\n+ mkdir -p \/amida\/sh\/tmp\/jenkins-backup\/jobs\n+ for i in plugins jobs users secrets nodes\n+ mkdir -p \/amida\/sh\/tmp\/jenkins-backup\/users\n+ for i in plugins jobs users secrets nodes\n+ mkdir -p \/amida\/sh\/tmp\/jenkins-backup\/secrets\n+ for i in plugins jobs users secrets nodes\n+ mkdir -p \/amida\/sh\/tmp\/jenkins-backup\/nodes\n+ cp \/var\/lib\/jenkins\/be.certipost.hudson.plugin.SCPRepositoryPublisher.xml \/var\/lib\/jenkins\/config.xml \/var\/lib\/jenkins\/credentials.xml \/var\/lib\/jenkins\/hudson.maven.MavenModuleSet.xml \/var\/lib\/jenkins\/hudson.model.UpdateCenter.xml \/var\/lib\/jenkins\/hudson.plugins.analysis.core.GlobalSettings.xml \/var\/lib\/jenkins\/hudson.plugins.disk_usage.DiskUsageProjectActionFactory.xml \/var\/lib\/jenkins\/hudson.plugins.disk_usage.DiskUsageProperty.xml \/var\/lib\/jenkins\/hudson.plugins.git.GitSCM.xml \/var\/lib\/jenkins\/hudson.plugins.git.GitTool.xml \/var\/lib\/jenkins\/hudson.plugins.jira.JiraProjectProperty.xml \/var\/lib\/jenkins\/hudson.plugins.phing.PhingBuilder.xml \/var\/lib\/jenkins\/hudson.plugins.phing.PhingInstallation.xml \/var\/lib\/jenkins\/hudson.scm.CVSSCM.xml \/var\/lib\/jenkins\/hudson.scm.SubversionSCM.xml \/var\/lib\/jenkins\/hudson.tasks.Ant.xml \/var\/lib\/jenkins\/hudson.tasks.Mailer.xml \/var\/lib\/jenkins\/hudson.tasks.Maven.xml \/var\/lib\/jenkins\/hudson.tasks.Shell.xml \/var\/lib\/jenkins\/hudson.triggers.SCMTrigger.xml \/var\/lib\/jenkins\/jenkins.metrics.api.MetricsAccessKey.xml \/var\/lib\/jenkins\/jenkins.model.ArtifactManagerConfiguration.xml \/var\/lib\/jenkins\/jenkins.model.DownloadSettings.xml \/var\/lib\/jenkins\/jenkins.model.JenkinsLocationConfiguration.xml \/var\/lib\/jenkins\/jenkins.mvn.GlobalMavenConfig.xml \/var\/lib\/jenkins\/jenkins.plugins.hipchat.HipChatNotifier.xml \/var\/lib\/jenkins\/jenkins.security.QueueItemAuthenticatorConfiguration.xml \/var\/lib\/jenkins\/nodeMonitors.xml \/var\/lib\/jenkins\/org.jenkinsci.plugins.gitclient.JGitTool.xml \/var\/lib\/jenkins\/org.jenkinsci.plugins.stashNotifier.StashNotifier.xml \/amida\/sh\/tmp\/jenkins-backup\n+ cp \/var\/lib\/jenkins\/plugins\/JiraTestResultReporter.jpi \/var\/lib\/jenkins\/plugins\/analysis-core.jpi \/var\/lib\/jenkins\/plugins\/ant.jpi \/var\/lib\/jenkins\/plugins\/antisamy-markup-formatter.jpi \/var\/lib\/jenkins\/plugins\/build-pipeline-plugin.jpi \/var\/lib\/jenkins\/plugins\/checkstyle.jpi \/var\/lib\/jenkins\/plugins\/cloverphp.jpi \/var\/lib\/jenkins\/plugins\/credentials.jpi \/var\/lib\/jenkins\/plugins\/cvs.jpi \/var\/lib\/jenkins\/plugins\/discard-old-build.jpi \/var\/lib\/jenkins\/plugins\/disk-usage.jpi \/var\/lib\/jenkins\/plugins\/dry.jpi \/var\/lib\/jenkins\/plugins\/external-monitor-job.jpi \/var\/lib\/jenkins\/plugins\/git-client.jpi \/var\/lib\/jenkins\/plugins\/git.jpi \/var\/lib\/jenkins\/plugins\/hipchat.jpi \/var\/lib\/jenkins\/plugins\/htmlpublisher.jpi \/var\/lib\/jenkins\/plugins\/jackson2-api.jpi \/var\/lib\/jenkins\/plugins\/javadoc.jpi \/var\/lib\/jenkins\/plugins\/jdepend.jpi \/var\/lib\/jenkins\/plugins\/jenkins-jira-issue-updater.jpi \/var\/lib\/jenkins\/plugins\/jira.jpi \/var\/lib\/jenkins\/plugins\/jquery.jpi \/var\/lib\/jenkins\/plugins\/junit.jpi \/var\/lib\/jenkins\/plugins\/ldap.jpi \/var\/lib\/jenkins\/plugins\/mailer.jpi \/var\/lib\/jenkins\/plugins\/mapdb-api.jpi \/var\/lib\/jenkins\/plugins\/matrix-auth.jpi \/var\/lib\/jenkins\/plugins\/matrix-project.jpi \/var\/lib\/jenkins\/plugins\/maven-plugin.jpi \/var\/lib\/jenkins\/plugins\/metrics-diskusage.jpi \/var\/lib\/jenkins\/plugins\/metrics.jpi \/var\/lib\/jenkins\/plugins\/pam-auth.jpi \/var\/lib\/jenkins\/plugins\/parameterized-trigger.jpi \/var\/lib\/jenkins\/plugins\/phing.jpi \/var\/lib\/jenkins\/plugins\/php.jpi \/var\/lib\/jenkins\/plugins\/plot.jpi \/var\/lib\/jenkins\/plugins\/pmd.jpi \/var\/lib\/jenkins\/plugins\/run-condition.jpi \/var\/lib\/jenkins\/plugins\/scm-api.jpi \/var\/lib\/jenkins\/plugins\/scp.jpi \/var\/lib\/jenkins\/plugins\/script-security.jpi \/var\/lib\/jenkins\/plugins\/ssh-agent.jpi \/var\/lib\/jenkins\/plugins\/ssh-credentials.jpi \/var\/lib\/jenkins\/plugins\/ssh-slaves.jpi \/var\/lib\/jenkins\/plugins\/stashNotifier.jpi \/var\/lib\/jenkins\/plugins\/subversion.jpi \/var\/lib\/jenkins\/plugins\/token-macro.jpi \/var\/lib\/jenkins\/plugins\/translation.jpi \/var\/lib\/jenkins\/plugins\/violations.jpi \/var\/lib\/jenkins\/plugins\/windows-slaves.jpi \/var\/lib\/jenkins\/plugins\/xunit.jpi \/amida\/sh\/tmp\/jenkins-backup\/plugins\n++ find \/var\/lib\/jenkins\/plugins\/ -name '*.hpi.pinned'\n++ wc -l\n+ hpi_pinned_count=0\n++ find \/var\/lib\/jenkins\/plugins\/ -name '*.jpi.pinned'\n++ wc -l\n+ jpi_pinned_count=3\n+ '[' 0 -ne 0 -o 3 -ne 0 ']'\n+ cp \/var\/lib\/jenkins\/plugins\/credentials.jpi.pinned \/var\/lib\/jenkins\/plugins\/junit.jpi.pinned \/var\/lib\/jenkins\/plugins\/ssh-credentials.jpi.pinned \/amida\/sh\/tmp\/jenkins-backup\/plugins\n++ ls -A \/var\/lib\/jenkins\/users\/\n+ '[' 'admin\nboner.engineer\nc-takamori\nd-yamamoto\ndev\ne-ishizaki\nfranky.xhl\nfrankyxhl\nh-ishiya\nh-nakamura\nh-tada\nh-yamane\nharuhan858\nk-fukuda\nk-higashio\nk-takahata\nk-tanaka\nm-haruta\nm-kinsei\nm-monkaku\nm-ueda\nmarketing\nmiwa\nn-ota\nr-sugawara\ns-tatemoto\ns-tsubouchi\ns-yamanaka\nt-hayashi\nt-hosokawa\nt-kakiuchi\nt-kawano\nt-tateyama\nt-uesugi\nt.goto\ntakahirokakiuchi\ntest\ntomita\nwebmaster\ny-fujiwara\ny-gu\ny-inazaki\ny-komurasaki\ny-mori\ny-sakai\ny-ueda' ']'\n+ cp -R \/var\/lib\/jenkins\/users\/admin \/var\/lib\/jenkins\/users\/boner.engineer \/var\/lib\/jenkins\/users\/c-takamori \/var\/lib\/jenkins\/users\/d-yamamoto \/var\/lib\/jenkins\/users\/dev \/var\/lib\/jenkins\/users\/e-ishizaki \/var\/lib\/jenkins\/users\/franky.xhl \/var\/lib\/jenkins\/users\/frankyxhl \/var\/lib\/jenkins\/users\/h-ishiya \/var\/lib\/jenkins\/users\/h-nakamura \/var\/lib\/jenkins\/users\/h-tada \/var\/lib\/jenkins\/users\/h-yamane \/var\/lib\/jenkins\/users\/haruhan858 \/var\/lib\/jenkins\/users\/k-fukuda \/var\/lib\/jenkins\/users\/k-higashio \/var\/lib\/jenkins\/users\/k-takahata \/var\/lib\/jenkins\/users\/k-tanaka \/var\/lib\/jenkins\/users\/m-haruta \/var\/lib\/jenkins\/users\/m-kinsei \/var\/lib\/jenkins\/users\/m-monkaku \/var\/lib\/jenkins\/users\/m-ueda \/var\/lib\/jenkins\/users\/marketing \/var\/lib\/jenkins\/users\/miwa \/var\/lib\/jenkins\/users\/n-ota \/var\/lib\/jenkins\/users\/r-sugawara \/var\/lib\/jenkins\/users\/s-tatemoto \/var\/lib\/jenkins\/users\/s-tsubouchi \/var\/lib\/jenkins\/users\/s-yamanaka \/var\/lib\/jenkins\/users\/t-hayashi \/var\/lib\/jenkins\/users\/t-hosokawa \/var\/lib\/jenkins\/users\/t-kakiuchi \/var\/lib\/jenkins\/users\/t-kawano \/var\/lib\/jenkins\/users\/t-tateyama \/var\/lib\/jenkins\/users\/t-uesugi \/var\/lib\/jenkins\/users\/t.goto \/var\/lib\/jenkins\/users\/takahirokakiuchi \/var\/lib\/jenkins\/users\/test \/var\/lib\/jenkins\/users\/tomita \/var\/lib\/jenkins\/users\/webmaster \/var\/lib\/jenkins\/users\/y-fujiwara \/var\/lib\/jenkins\/users\/y-gu \/var\/lib\/jenkins\/users\/y-inazaki \/var\/lib\/jenkins\/users\/y-komurasaki \/var\/lib\/jenkins\/users\/y-mori \/var\/lib\/jenkins\/users\/y-sakai \/var\/lib\/jenkins\/users\/y-ueda \/amida\/sh\/tmp\/jenkins-backup\/users\n++ ls -A \/var\/lib\/jenkins\/secrets\/\n+ '[' 'filepath-filters.d\nhudson.console.AnnotatedLargeText.consoleAnnotator\nhudson.model.Job.serverCookie\nhudson.util.Secret\njenkins.model.Jenkins.crumbSalt\njenkins.security.ApiTokenProperty.seed\nmaster.key\norg.acegisecurity.ui.rememberme.TokenBasedRememberMeServices.mac\norg.jenkinsci.main.modules.instance_identity.InstanceIdentity.KEY\nwhitelisted-callables.d' ']'\n+ cp -R \/var\/lib\/jenkins\/secrets\/filepath-filters.d \/var\/lib\/jenkins\/secrets\/hudson.console.AnnotatedLargeText.consoleAnnotator \/var\/lib\/jenkins\/secrets\/hudson.model.Job.serverCookie \/var\/lib\/jenkins\/secrets\/hudson.util.Secret \/var\/lib\/jenkins\/secrets\/jenkins.model.Jenkins.crumbSalt \/var\/lib\/jenkins\/secrets\/jenkins.security.ApiTokenProperty.seed \/var\/lib\/jenkins\/secrets\/master.key \/var\/lib\/jenkins\/secrets\/org.acegisecurity.ui.rememberme.TokenBasedRememberMeServices.mac \/var\/lib\/jenkins\/secrets\/org.jenkinsci.main.modules.instance_identity.InstanceIdentity.KEY \/var\/lib\/jenkins\/secrets\/whitelisted-callables.d \/amida\/sh\/tmp\/jenkins-backup\/secrets\n++ ls -A \/var\/lib\/jenkins\/nodes\/\n+ '[' '' ']'\n++ ls -A \/var\/lib\/jenkins\/jobs\/\n+ '[' 'test\n?yadd?zSTG?????[?X\n?yadd?z?{?ԃ????[?X\n?yadd?z?{?ԃ????[?X(web01)\n?yadd?z?{?ԃ????[?X(web02)\n?yapis.ssl?zDEV?e?X?g\n?yapis.ssl?zQC?e?X?g\n?yapis.ssl?zQC?????[?X\n?yapis.ssl?zQC?????[?X?e?X?g?p\n?yapis.ssl?zSTG?????[?X\n?yapis.ssl?z?R?[?h?`?F?b?N\n?yapis.ssl?z?{?ԃ????[?X\n?yapis.ssl?z?{?ԃ????[?X(api01)\n?yapis.ssl?z?{?ԃ????[?X(api02)\n?yatgomin?zPRE?????[?X\n?yatgomin?zSTG?????[?X\n?yatgomin?z?{?ԃ????[?X\n?yatgomin?z?{?ԃ????[?X(web01)\n?yatgomin?z?{?ԃ????[?X(web02)\n?yathanko.ssl?zDEV?e?X?g\n?yathanko.ssl?zQC?e?X?g\n?yathanko.ssl?zQC?????[?X\n?yathanko.ssl?zSTG?????[?X\n?yathanko.ssl?z?{?ԃ????[?X\n?yathanko.ssl?z?{?ԃ????[?X(web01)\n?yathanko.ssl?z?{?ԃ????[?X(web02)\n?yathanko?zPRE?????[?X_?e?X?g?p\n?yathanko?zSTG?????[?X\n?yathanko?z?{?ԃ????[?X\n?yathanko?z?{?ԃ????[?X(web01)\n?yathanko?z?{?ԃ????[?X(web02)\n?yattitan?zSTG?????[?X\n?yattitan?z?{?ԃ????[?X\n?yattitan?z?{?ԃ????[?X(web01)\n?yattitan?z?{?ԃ????[?X(web02)\n?ybatch?zDEV?e?X?g\n?ybatch?zQC?e?X?g\n?ybatch?zQC?????[?X\n?ybatch?zSTG?????[?X\n?ybatch?z?R?[?h?`?F?b?N\n?ybatch?z?{?ԃ????[?X\n?ycalendar?zSTG?????[?X\n?ycalendar?z?{?ԃ????[?X\n?ycalendar?z?{?ԃ????[?X(web01)\n?ycalendar?z?{?ԃ????[?X(web02)\n?ycard?zSTG?????[?X\n?ycard?z?{?ԃ????[?X\n?ycard?z?{?ԃ????[?X(web01)\n?ycard?z?{?ԃ????[?X(web02)\n?ycase?zSTG?????[?X\n?ycase?z?{?ԃ????[?X\n?ycase?z?{?ԃ????[?X(web01)\n?ycase?z?{?ԃ????[?X(web02)\n?ycode925?zSTG?????[?X\n?ycode925?z?{?ԃ????[?X\n?ycode925?z?{?ԃ????[?X(web01)\n?ycode925?z?{?ԃ????[?X(web02)\n?ycommon?zQC?????[?X\n?ycommon?zSTG?????[?X\n?ycommon?z?{?ԃ????[?X\n?ycommon?z?{?ԃ????[?X(web01)\n?ycommon?z?{?ԃ????[?X(web02)\n?yeprint?zSTG?????[?X\n?yeprint?z?{?ԃ????[?X\n?yeprint?z?{?ԃ????[?X(web01)\n?yeprint?z?{?ԃ????[?X(web02)\n?yfudepen?zSTG?????[?X\n?yfudepen?z?{?ԃ????[?X\n?yfudepen?z?{?ԃ????[?X(web01)\n?yfudepen?z?{?ԃ????[?X(web02)\n?yfuto?zSTG?????[?X\n?yfuto?z?{?ԃ????[?X\n?yfuto?z?{?ԃ????[?X(web01)\n?yfuto?z?{?ԃ????[?X(web02)\n?ygomin?zSTG?????[?X\n?ygomin?z?{?ԃ????[?X\n?ygomin?z?{?ԃ????[?X(web01)\n?ygomin?z?{?ԃ????[?X(web02)\n?yhagaki_system2009?zQC?????[?X\n?yhagaki_system2009?z?{?ԃ????[?X\n?yhagaki?zSTG?????[?X\n?yhagaki?z?{?ԃ????[?X\n?yhagaki?z?{?ԃ????[?X(web01)\n?yhagaki?z?{?ԃ????[?X(web02)\n?yhancode?z?{?ԃ????[?X\n?yhankoya.ssl?zDEV?e?X?g\n?yhankoya.ssl?zQC?e?X?g\n?yhankoya.ssl?zQC?????[?X\n?yhankoya.ssl?zSTG?????[?X\n?yhankoya.ssl?z?R?[?h?`?F?b?N\n?yhankoya.ssl?z?{?ԃ????[?X\n?yhankoya.ssl?z?{?ԃ????[?X(web01)\n?yhankoya.ssl?z?{?ԃ????[?X(web02)\n?yhankoya?zPRE?????[?X\n?yhankoya?zSTG?????[?X\n?yhankoya?z?{?ԃ????[?X\n?yhankoya?z?{?ԃ????[?X(web01)\n?yhankoya?z?{?ԃ????[?X(web02)\n?yimage?zSTG?????[?X\n?yimage?z?{?ԃ????[?X\n?yimage?z?{?ԃ????[?X(web01)\n?yimage?z?{?ԃ????[?X(web02)\n?yinkuya?zSTG?????[?X\n?yinkuya?z?{?ԃ????[?X\n?yinkuya?z?{?ԃ????[?X(web01)\n?yinkuya?z?{?ԃ????[?X(web02)\n?yinshosya.ssl?zDEV?e?X?g\n?yinshosya.ssl?zQC?e?X?g\n?yinshosya.ssl?zQC?????[?X\n?yinshosya.ssl?zSTG?????[?X\n?yinshosya.ssl?z?{?ԃ????[?X\n?yinshosya.ssl?z?{?ԃ????[?X(web01)\n?yinshosya.ssl?z?{?ԃ????[?X(web02)\n?yinshosya?zSTG?????[?X\n?yinshosya?z?{?ԃ????[?X\n?yinshosya?z?{?ԃ????[?X(web01)\n?yinshosya?z?{?ԃ????[?X(web02)\n?yippin?zSTG?????[?X\n?yippin?z?{?ԃ????[?X\n?yippin?z?{?ԃ????[?X(web01)\n?yippin?z?{?ԃ????[?X(web02)\n?ymobi?zSTG?????[?X\n?ymobi?z?{?ԃ????[?X\n?ymobi?z?{?ԃ????[?X(web01)\n?ymobi?z?{?ԃ????[?X(web02)\n?ynaire?zSTG?????[?X\n?yname?zSTG?????[?X\n?yname?z?{?ԃ????[?X\n?yname?z?{?ԃ????[?X(web01)\n?yname?z?{?ԃ????[?X(web02)\n?yonamae?zSTG?????[?X\n?yonamae?z?{?ԃ????[?X\n?yonamae?z?{?ԃ????[?X(web01)\n?yonamae?z?{?ԃ????[?X(web02)\n?yplate?zSTG?????[?X\n?yplate?z?{?ԃ????[?X\n?yplate?z?{?ԃ????[?X(web01)\n?yplate?z?{?ԃ????[?X(web02)\n?ypop?zSTG?????[?X\n?ypop?z?{?ԃ????[?X\n?ypop?z?{?ԃ????[?X(web01)\n?ypop?z?{?ԃ????[?X(web02)\n?ypost?zSTG?????[?X\n?ypost?z?{?ԃ????[?X\n?ypost?z?{?ԃ????[?X(web01)\n?ypost?z?{?ԃ????[?X(web02)\n?yrasica?zSTG?????[?X\n?yshachi_a?zSTG?????[?X\n?yshachi_a?z?{?ԃ????[?X\n?yshachi_a?z?{?ԃ????[?X(web01)\n?yshachi_a?z?{?ԃ????[?X(web02)\n?yshachi_biz?zSTG?????[?X\n?yshachi_biz?z?{?ԃ????[?X\n?yshachi_biz?z?{?ԃ????[?X(web01)\n?yshachi_biz?z?{?ԃ????[?X(web02)\n?yshachi_b?zSTG?????[?X\n?yshachi_b?z?{?ԃ????[?X\n?yshachi_b?z?{?ԃ????[?X(web01)\n?yshachi_b?z?{?ԃ????[?X(web02)\n?yshachihata?zPRE?????[?X\n?yshachihata?zSTG?????[?X\n?yshachihata?z?{?ԃ????[?X\n?yshachihata?z?{?ԃ????[?X(web01)\n?yshachihata?z?{?ԃ????[?X(web02)\n?ysp_gomin?zSTG?????[?X\n?ysp_gomin?z?{?ԃ????[?X\n?ysp_gomin?z?{?ԃ????[?X(web01)\n?ysp_gomin?z?{?ԃ????[?X(web02)\n?ystamper?zSTG?????[?X\n?ystamper?z?{?ԃ????[?X\n?ystamper?z?{?ԃ????[?X(web01)\n?ystamper?z?{?ԃ????[?X(web02)\n?ystamp?zSTG?????[?X\n?ystamp?z?{?ԃ????[?X\n?ystamp?z?{?ԃ????[?X(web01)\n?ystamp?z?{?ԃ????[?X(web02)\n?ytechouya?zSTG?????[?X\n?ytechouya?z?{?ԃ????[?X\n?ytechouya?z?{?ԃ????[?X(web01)\n?ytechouya?z?{?ԃ????[?X(web02)\n?ytest?zQC?????[?X\n?ytitan?zPRE?????[?X\n?ytitan?zSTG?????[?X\n?ytitan?z?{?ԃ????[?X\n?ytitan?z?{?ԃ????[?X(web01)\n?ytitan?z?{?ԃ????[?X(web02)\n?ytowel?zSTG?????[?X\n?ytowel?z?{?ԃ????[?X\n?ytowel?z?{?ԃ????[?X(web01)\n?ytowel?z?{?ԃ????[?X(web02)\n?ywoman?zPRE?????[?X\n?ywoman?zSTG?????[?X\n?ywoman?z?{?ԃ????[?X\n?ywoman?z?{?ԃ????[?X(web01)\n?ywoman?z?{?ԃ????[?X(web02)\n?yxprint?zSTG?????[?X\n?yxprint?z?{?ԃ????[?X\n?yxprint?z?{?ԃ????[?X(web01)\n?yxprint?z?{?ԃ????[?X(web02)' ']'\n+ backup_jobs \/var\/lib\/jenkins\/jobs\/\n+ local run_in_path=\/var\/lib\/jenkins\/jobs\/\n+ local rel_depth=\n+ cd \/var\/lib\/jenkins\/jobs\/\n+ find . -maxdepth 1 -type d\n+ read job_name\n+ '[' . = . ']'\n+ continue\n+ read job_name\n+ '[' .\/test = . ']'\n+ '[' .\/test = .. ']'\n+ '[' -d \/var\/lib\/jenkins\/jobs\/\/.\/test ']'\n+ mkdir -p \/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/test\/\n+ xargs -0 -I '{}' cp '{}' \/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/test\/\n+ find \/var\/lib\/jenkins\/jobs\/\/.\/test\/ -maxdepth 1 -name '*.xml' -print0\n+ '[' -f \/var\/lib\/jenkins\/jobs\/\/.\/test\/config.xml ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder \/var\/lib\/jenkins\/jobs\/\/.\/test\/config.xml\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220attitan\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hagaki_system2009\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220test\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220add\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220calendar\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210' = . ']'\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221DEV\\343\\203\\206\\343\\202\\271\\343\\203\\210\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220common\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220atgomin\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221QC\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yapis.ssl?z?{?ԃ????[?X(api01)' = . ']'\n+ '[' '.\/?yapis.ssl?z?{?ԃ????[?X(api01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api01)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api01)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' = . ']'\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220card\\343\\200\\221STG\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yapis.ssl?z?{?ԃ????[?X(api02)' = . ']'\n+ '[' '.\/?yapis.ssl?z?{?ԃ????[?X(api02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yapis.ssl?z?{?ԃ????[?X(api02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yhankoya?z?{?ԃ????[?X(web01)' = . ']'\n+ '[' '.\/?yhankoya?z?{?ԃ????[?X(web01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web01)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web01)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yhankoya?z?{?ԃ????[?X(web02)' = . ']'\n+ '[' '.\/?yhankoya?z?{?ԃ????[?X(web02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya?z?{?ԃ????[?X(web02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)' = . ']'\n+ '[' '.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)' = . ']'\n+ '[' '.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yhankoya.ssl?z?{?ԃ????[?X(web02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yathanko?z?{?ԃ????[?X(web02)' = . ']'\n+ '[' '.\/?yathanko?z?{?ԃ????[?X(web02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko?z?{?ԃ????[?X(web02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yathanko?z?{?ԃ????[?X(web02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yathanko?z?{?ԃ????[?X(web02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko?z?{?ԃ????[?X(web02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko?z?{?ԃ????[?X(web02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko?z?{?ԃ????[?X(web02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yathanko.ssl?z?{?ԃ????[?X(web01)' = . ']'\n+ '[' '.\/?yathanko.ssl?z?{?ԃ????[?X(web01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web01)\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web01)\/'\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yathanko.ssl?z?{?ԃ????[?X(web02)' = . ']'\n+ '[' '.\/?yathanko.ssl?z?{?ԃ????[?X(web02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yathanko.ssl?z?{?ԃ????[?X(web02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)' = . ']'\n+ '[' '.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220athanko.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yinshosya?z?{?ԃ????[?X(web02)' = . ']'\n+ '[' '.\/?yinshosya?z?{?ԃ????[?X(web02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yadd?z?{?ԃ????[?X(web01)' = . ']'\n+ '[' '.\/?yadd?z?{?ԃ????[?X(web01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yadd?z?{?ԃ????[?X(web01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yadd?z?{?ԃ????[?X(web01)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yadd?z?{?ԃ????[?X(web01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yadd?z?{?ԃ????[?X(web01)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yadd?z?{?ԃ????[?X(web01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yadd?z?{?ԃ????[?X(web01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)' = . ']'\n+ '[' '.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya.ssl?z?{?ԃ????[?X(web02)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' '.\/?yinshosya?z?{?ԃ????[?X(web01)' = . ']'\n+ '[' '.\/?yinshosya?z?{?ԃ????[?X(web01)' = .. ']'\n+ '[' -d '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web01)' ']'\n+ mkdir -p '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web01)\/'\n+ xargs -0 -I '{}' cp '{}' '\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web01)\/'\n+ find '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web01)\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web01)\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder '\/var\/lib\/jenkins\/jobs\/\/.\/?yinshosya?z?{?ԃ????[?X(web01)\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = . ']'\n+ '[' $'.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220inshosya.ssl\\343\\200\\221\\346\\234\\254\\347\\225\\252\\343\\203\\252\\343\\203\\252\\343\\203\\274\\343\\202\\271\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' = . ']'\n+ '[' $'.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220hankoya.ssl\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' = . ']'\n+ '[' $'.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/'\n+ xargs -0 -I '{}' cp '{}' $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/'\n+ find $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/' -maxdepth 1 -name '*.xml' -print0\n+ '[' -f $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/config.xml' ']'\n++ grep -c com.cloudbees.hudson.plugins.folder.Folder $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220batch\\343\\200\\221\\343\\202\\263\\343\\203\\274\\343\\203\\211\\343\\203\\201\\343\\202\\247\\343\\203\\203\\343\\202\\257\/config.xml'\n+ '[' 0 -ge 1 ']'\n+ true\n+ read job_name\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\206\\343\\202\\271\\343\\203\\210' = . ']'\n+ '[' $'.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\206\\343\\202\\271\\343\\203\\210' = .. ']'\n+ '[' -d $'\/var\/lib\/jenkins\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203\\206\\343\\202\\271\\343\\203\\210' ']'\n+ mkdir -p $'\/amida\/sh\/tmp\/jenkins-backup\/jobs\/\/.\/\\343\\200\\220apis.ssl\\343\\200\\221QC\\343\\203", "std_err": "", "return_code": 0, "signal": 0, "run_user": "", "run_user_password": "" } }
 :20170228:125055.317 [DEBUG] In DBconnect() flag:0
 :20170228:125055.323 [DEBUG] query [txnlev:0] [set names utf8]
 :20170228:125055.323 [DEBUG] End of DBconnect():0
 :20170228:125055.323 [DEBUG] In jatrap_kind()
 :20170228:125055.323 [DEBUG] In ja_telegram_check()
 :20170228:125055.324 [DEBUG] In jatrap_auth_host()
 :20170228:125055.324 [DEBUG] In ja_telegram_check()
 :20170228:125055.324 [DEBUG] In ja_host_auth() host: ci01
 :20170228:125055.324 [DEBUG] In ja_host_getip() host: ci01
 :20170228:125055.324 [DEBUG] query [txnlev:0] [ select i.hostid, i.useip, i.dns, i.ip, h.status, i.port from hosts h, interface i where h.hostid = i.hostid and i.main = 1 and h.host = 'ci01']
 :20170228:125055.325 [DEBUG] query [txnlev:0] [select force_flag, job_id from ja_run_job_table where inner_job_id = 550]
 :20170228:125055.325 [DEBUG] In jatrap_jobresult()
 :20170228:125055.325 [DEBUG] In ja_telegram_check()
 :20170228:125055.325 [DEBUG] In jatrap_jobresult_load()
 :20170228:125055.325 [DEBUG] In ja_telegram_check()
 :20170228:125055.326 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.326 [DEBUG] query [txnlev:1] [select inner_jobnet_id, job_type, status from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125055.327 [DEBUG] In jatrap_jobresult_set_value()
 :20170228:125055.327 [DEBUG] In ja_set_value_after() inner_job_id: 550, inner_jobnet_id: 1500000000000000070
 :20170228:125055.408 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125055.408 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125055.408 [DEBUG] sleeping for 1 seconds
 :20170228:125055.441 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, job_type, method_flag, timeout_flag, start_time from ja_run_job_table where status = 2]
 :20170228:125055.441 [DEBUG] In process_jajob() ja_run_job_table(status: RUN): 0.000572 sec.
 :20170228:125055.441 [DEBUG] inner_job_id: 550, method_flag: 0, job_type: 4
 :20170228:125055.441 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.441 [DEBUG] query [txnlev:1] [select inner_job_id from ja_run_job_table where inner_job_id = 550 for update]
 :20170228:125055.468 [DEBUG] In get_purge_date(60)
 :20170228:125055.468 [DEBUG] In get_purge_date(43200)
 :20170228:125055.468 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125055.468 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125055.469 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000678 seconds while processing rules
 :20170228:125055.469 [DEBUG] In joblog_purge(201701291250)
 :20170228:125055.469 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125055.470 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000510 seconds while processing rules
 :20170228:125055.470 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125055.470 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125055.470 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000420 seconds while processing rules
 :20170228:125055.470 [DEBUG] sleeping for 1 seconds
 :20170228:125055.474 [DEBUG] In message_purge()
 :20170228:125055.474 [DEBUG] In get_purge_date(1440)
 :20170228:125055.474 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.474 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125055.475 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.475 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.475 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125055.475 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.476 [DEBUG] message send #1 (message purge) spent 0.001827 seconds while processing rules
 :20170228:125055.476 [DEBUG] In message_send()
 :20170228:125055.476 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125055 order by retry_date, message_date]
 :20170228:125055.476 [DEBUG] message send #1 (message send) spent 0.000495 seconds while processing rules
 :20170228:125055.476 [DEBUG] sleeping for 1 seconds
 :20170228:125055.494 [DEBUG] In jobnet_load_immediate()
 :20170228:125055.495 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125055.495 [DEBUG] job loader #1 (immediate start) spent 0.000995 seconds while processing rules
 :20170228:125055.496 [DEBUG] sleeping for 1 seconds
 :20170228:125055.516 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125055.517 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000994 sec.
 :20170228:125055.517 [DEBUG] End of process_jarun()
 :20170228:125055.517 [DEBUG] sleeping for 1 seconds
 :20170228:125055.530 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125055.530 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000663 sec.
 :20170228:125055.530 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125055.530 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.531 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.531 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125055.531 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.531 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.531 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125055.531 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.532 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.532 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125055.532 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.532 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.532 [DEBUG] End of process_jajobnet_summary()
 :20170228:125055.532 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, timeout_flag, status from ja_run_jobnet_table where status in (1, 2 ,4)]
 :20170228:125055.533 [DEBUG] In process_jajobnet() ja_run_jobnet_table(status): 0.000343 sec.
 :20170228:125055.533 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000044] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125055.533 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.534 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125055.534 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000044]
 :20170228:125055.534 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000044) 0.000413 sec.
 :20170228:125055.534 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000044, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125055.534 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.535 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000045] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125055.535 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.535 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125055.535 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000045]
 :20170228:125055.536 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000045) 0.000411 sec.
 :20170228:125055.536 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000045, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125055.536 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.536 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000055] inner_job_id[0] timeout_flag[0] status[4]
 :20170228:125055.536 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.536 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, icon_jobnet_id: 0, status: 4, timeout_flag: 0
 :20170228:125055.536 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000055]
 :20170228:125055.536 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000055) 0.000327 sec.
 :20170228:125055.537 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000055, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 0, runerr: 1, end: 1, timeout: 0
 :20170228:125055.537 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.537 [DEBUG] In process_jajobnet() ja_run_jobnet_table read. inner_jobnet_id[1500000000000000070] inner_job_id[0] timeout_flag[0] status[2]
 :20170228:125055.537 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125055.537 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, icon_jobnet_id: 0, status: 2, timeout_flag: 0
 :20170228:125055.537 [DEBUG] query [txnlev:1] [select inner_job_id, status, job_type, test_flag, timeout_flag, inner_jobnet_main_id, job_id, continue_flag from ja_run_job_table where inner_jobnet_id = 1500000000000000070]
 :20170228:125055.538 [DEBUG] In jajobnet_run() ja_run_jobnet_table:(inner_jobnet_id: 1500000000000000070) 0.000385 sec.
 :20170228:125055.538 [DEBUG] In jajobnet_run() inner_jobnet_id: 1500000000000000070, start_icons: 1, end_icons: 1, end_icons_end: 0, ready: 0, run: 1, runerr: 0, end: 1, timeout: 0
 :20170228:125055.538 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125055.538 [DEBUG] End of process_jajobnet()
 :20170228:125055.538 [DEBUG] sleeping for 1 seconds
 :20170228:125056.409 [DEBUG] In ja_collect_selfmon_stats()
 :20170228:125056.409 [DEBUG] End of ja_collect_selfmon_stats()
 :20170228:125056.409 [DEBUG] sleeping for 1 seconds
 :20170228:125056.470 [DEBUG] In get_purge_date(60)
 :20170228:125056.471 [DEBUG] In get_purge_date(43200)
 :20170228:125056.471 [DEBUG] In jobnet_purge(201702281150)
 :20170228:125056.471 [DEBUG] query [txnlev:0] [select inner_jobnet_id, jobnet_id, update_date, status from ja_run_jobnet_summary_table where end_time <= 20170228115059 and status in(3, 5)]
 :20170228:125056.471 [DEBUG] jobnet boot #1 (jobnet purge) spent 0.000801 seconds while processing rules
 :20170228:125056.472 [DEBUG] In joblog_purge(201701291250)
 :20170228:125056.472 [DEBUG] query [txnlev:0] [select inner_jobnet_main_id from ja_run_log_table where log_date <= 20170129125059999 group by inner_jobnet_main_id]
 :20170228:125056.472 [DEBUG] jobnet boot #1 (joblog purge) spent 0.000833 seconds while processing rules
 :20170228:125056.472 [DEBUG] In jobnet_boot(201702281250)
 :20170228:125056.472 [DEBUG] query [txnlev:0] [select inner_jobnet_id, run_type, scheduled_time, jobnet_id, update_date, multiple_start_up, load_status, start_pending_flag from ja_run_jobnet_summary_table where status = 0 and start_pending_flag != 1 and (scheduled_time <= 201702281250 or scheduled_time = 0) order by scheduled_time, inner_jobnet_id]
 :20170228:125056.473 [DEBUG] jobnet boot #1 (jobnet start) spent 0.000895 seconds while processing rules
 :20170228:125056.473 [DEBUG] sleeping for 1 seconds
 :20170228:125056.477 [DEBUG] In message_purge()
 :20170228:125056.477 [DEBUG] In get_purge_date(1440)
 :20170228:125056.477 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125056.478 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 1 and send_date <= 20170227125059]
 :20170228:125056.479 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125056.479 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125056.480 [DEBUG] query [txnlev:1] [delete from ja_send_message_table where send_status = 3 and send_error_date <= 20170227125059]
 :20170228:125056.481 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125056.482 [DEBUG] message send #1 (message purge) spent 0.004508 seconds while processing rules
 :20170228:125056.482 [DEBUG] In message_send()
 :20170228:125056.482 [DEBUG] query [txnlev:0] [select send_no, message_date, send_status, retry_count, retry_date, message_type, user_name, host_name, jobnet_id, jobnet_name, job_id, job_id_full, job_name, log_message_id, log_message from ja_send_message_table where (send_status = 0 or send_status = 2) and retry_date <= 20170228125056 order by retry_date, message_date]
 :20170228:125056.482 [DEBUG] message send #1 (message send) spent 0.000747 seconds while processing rules
 :20170228:125056.483 [DEBUG] sleeping for 1 seconds
 :20170228:125056.496 [DEBUG] In jobnet_load_immediate()
 :20170228:125056.496 [DEBUG] query [txnlev:0] [select inner_jobnet_id, inner_job_id, update_date, run_type, scheduled_time, public_flag, jobnet_id, user_name, jobnet_name, memo, execution_user_name, multiple_start_up, initial_scheduled_time from ja_run_jobnet_table where run_type <> 0 and main_flag = 0 and status = 0]
 :20170228:125056.497 [DEBUG] job loader #1 (immediate start) spent 0.001205 seconds while processing rules
 :20170228:125056.497 [DEBUG] sleeping for 1 seconds
 :20170228:125056.518 [DEBUG] query [txnlev:0] [select inner_job_id, inner_jobnet_id, method_flag, job_type, test_flag from ja_run_job_table where status = 1 ]
 :20170228:125056.519 [DEBUG] In process_jarun() ja_run_job_table(status = READY): 0.000717 sec.
 :20170228:125056.519 [DEBUG] End of process_jarun()
 :20170228:125056.519 [DEBUG] sleeping for 1 seconds
 :20170228:125056.539 [DEBUG] query [txnlev:0] [select inner_jobnet_id, status, jobnet_abort_flag from ja_run_jobnet_summary_table where status in (1, 2)]
 :20170228:125056.539 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table(status): 0.000734 sec.
 :20170228:125056.539 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000044] status[2] jobnet_abort_flag[0]
 :20170228:125056.540 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125056.540 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125056.540 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000045] status[2] jobnet_abort_flag[0]
 :20170228:125056.540 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125056.540 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125056.541 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000055] status[2] jobnet_abort_flag[0]
 :20170228:125056.541 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125056.541 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125056.541 [DEBUG] In process_jajobnet_summary() ja_run_jobnet_summary_table read. inner_jobnet_id[1500000000000000070] status[2] jobnet_abort_flag[0]
 :20170228:125056.542 [DEBUG] query [txnlev:1] [begin;]
 :20170228:125056.542 [DEBUG] query [txnlev:1] [commit;]
 :20170228:125056.542 [DEBUG] End of process_jajobnet_summary()

« 前
1
2
3
4
次 »

(1-1/4)

プロジェクト

全般

プロフィール

Job Arranger for Zabbix

その他問い合わせ #2475 » デバックログ.txt