complete
timeout obligations
all_obligations_satisfied
| Obligation / exact reason | Outcome | Expected | Observed evidence |
|---|---|---|---|
| baseline_validityall_obligations_satisfied | PASS | {
"deferred_release": true,
"facts": {
"job_id": 1,
"value": 420
},
"message": 1,
"normal": 2
} | #25#90#43Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"api": "devctl",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "normal",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
},
"event": "result",
"kind": "producer-event",
"ns": "38227870956140",
"pid": "781070356",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"api": "devctl",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "normal",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
},
"event": "result",
"kind": "producer-event",
"ns": "38227978695754",
"pid": "781094930",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"api": "MsgSendv",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "message",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
},
"event": "result",
"kind": "producer-event",
"ns": "38227897895855",
"pid": "781078546",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| pending_preconditionall_obligations_satisfied | PASS | {
"confirmed_before_trigger": true,
"live_unblock_required": true,
"pending": 1
} | #127#126#128Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"deadline_ns": "38228521101602",
"operation": "timed",
"timeout_ms": 500
},
"event": "deadline",
"kind": "producer-event",
"ns": "38228021110618",
"pid": "781107218",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"client_pid": "781107218",
"generation": "3",
"logical": "4",
"pending": 1,
"rcvid": "4618722897140121601"
},
"event": "pending",
"kind": "producer-event",
"ns": "38228021349928",
"pid": "781053973",
"producer": "fixture",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 49,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"generation": "3",
"live": 1,
"logical": "4",
"mode": "corrected",
"rcvid": "4618722897140121601"
},
"event": "unblock",
"kind": "producer-event",
"ns": "38228521749288",
"pid": "781053973",
"producer": "fixture",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 50,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| cancellation_completionall_obligations_satisfied | PASS | {
"allowance_ms": 2000,
"api": "MsgSendv",
"error_name": "ETIMEDOUT",
"raw_return": -1
} | #135Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"api": "MsgSendv",
"api_error": 260,
"error_name": "ETIMEDOUT",
"facts": {},
"normalized": "TIMEOUT",
"operation": "timed",
"raw_errno": 260,
"raw_return": -1,
"result_shape": "integer-record"
},
"event": "result",
"kind": "producer-event",
"ns": "38228522577501",
"pid": "781107218",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 3,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| terminal_reply_observationall_obligations_satisfied | PASS | {
"primary_reply_error": 0,
"primary_reply_rc": 0
} | #130#131Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"error": 0,
"generation": "3",
"logical": "4",
"rc": 0
},
"event": "cancel_completed",
"kind": "producer-event",
"ns": "38228523244878",
"pid": "781053973",
"producer": "fixture",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 52,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"generation": "3",
"logical": "4",
"pending": 0,
"reason": "cancellation"
},
"event": "removed",
"kind": "producer-event",
"ns": "38228523332158",
"pid": "781053973",
"producer": "fixture",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 53,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| state_observationall_obligations_satisfied | PASS | {
"error": 0,
"same_generation": true
} | #145Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"completed": 1,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 0
},
"generation": "3",
"operation": "state",
"pending": 0,
"unblocks": 1
},
"event": "control_result",
"kind": "producer-event",
"ns": "38228549620275",
"pid": "781185042",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| pending_state_cleanupall_obligations_satisfied | PASS | {
"pending": 0
} | #145Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"completed": 1,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 0
},
"generation": "3",
"operation": "state",
"pending": 0,
"unblocks": 1
},
"event": "control_result",
"kind": "producer-event",
"ns": "38228549620275",
"pid": "781185042",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| state_factsall_obligations_satisfied | PASS | {
"job_exists": 1,
"job_ready": 0
} | #145Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"completed": 1,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 0
},
"generation": "3",
"operation": "state",
"pending": 0,
"unblocks": 1
},
"event": "control_result",
"kind": "producer-event",
"ns": "38228549620275",
"pid": "781185042",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| fresh_client_healthall_obligations_satisfied | PASS | {
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"original_instance": true
} | #178Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"api": "devctl",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "health",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
},
"event": "result",
"kind": "producer-event",
"ns": "38228601093639",
"pid": "781193234",
"producer": "worker",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 2,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| owned_process_cleanupall_obligations_satisfied | PASS | {
"all_owned_children_reaped": true
} | #189#16#31#46#59#73#93#95#118#138#152#166#181#187Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"all_reaped": 1,
"evidence_error": 0
},
"event": "cleanup",
"kind": "producer-event",
"ns": "38228606210619",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 68,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781062162",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227849056726",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 7,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781070356",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227875251741",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 12,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781078546",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227899521966",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 17,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781082647",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227920380997",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 22,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781090834",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227940102478",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 27,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781094930",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227980783072",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 33,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781094935",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38227980921998",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 35,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781103122",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38228000336052",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 40,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781107218",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38228525406513",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 45,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781185042",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38228551102971",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 50,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781189138",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38228577964753",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 55,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781193234",
"raw_status": 0
},
"event": "reaped",
"kind": "producer-event",
"ns": "38228604249182",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 60,
"service_instance_id": "p10demo2-job-timeout"
},
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"child_pid": "781053973",
"raw_status": 15
},
"event": "reaped",
"kind": "producer-event",
"ns": "38228606028394",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 66,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| evidence_completenessall_obligations_satisfied | PASS | {
"complete_required_evidence": true
} | #190Inspect recorded values{
"events": [
{
"attempt_id": "attempt1",
"case_id": "timeout",
"cycle": 1,
"data": {
"cleanup_ok": 1,
"evidence_error": 0,
"flow_complete": 1
},
"event": "run_final",
"kind": "producer-event",
"ns": "38228621245450",
"pid": "781049878",
"producer": "supervisor",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"seq": 69,
"service_instance_id": "p10demo2-job-timeout"
}
],
"status": null
} |
| target_completion_statusall_obligations_satisfied | PASS | {
"finalized": true,
"identity_and_ownership_bound": true
} | Inspect recorded values{
"events": [],
"status": {
"attempt_id": "attempt1",
"case_id": "timeout",
"cleanup_ok": true,
"cycle": 1,
"event_file": "events.jsonl",
"exit_code": 0,
"kind": "run-status",
"lab_control": "none",
"profile_sha256": "511cb8cc217ff0ced3df4d9ddf16e381118210845e120a59e35b205f46e6e438",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"service_instance_id": "p10demo2-job-timeout",
"source_tree_sha256": "08b20033edf22f6e0427b75b754a96d8f9fcdb358b8bbea51d224a4cc9e7e041",
"started_ns": "38227797133083",
"state": "complete",
"supervisor_pid": "781049878",
"unresolved": []
}
} |
Original build, contract and bundle identity
- Native run
p10demo2-job-timeout- Bundle ID
d3cc556eff8ecb945c932072db8d4789b020528f9fb48d9eca91895b3ec4fdac- Native source
39b99d7a163c21c88d831456cc438e3c02a56ac9- Source digest
08b20033edf22f6e0427b75b754a96d8f9fcdb358b8bbea51d224a4cc9e7e041- Fixture SHA-256
4dcc02efab57872cc654358b4613342bf1c8eda716954da12209ef4813bded7c- Runner SHA-256
2e33a3fb14996fca493117ff7429f4e91cb36887e0c595ffd2aae75cbc95e334- Worker SHA-256
d90e77e28be08e6dcbab2697586a5305b4b189365ab83425f43b0cd253d23c43- Profile hash
511cb8cc217ff0ced3df4d9ddf16e381118210845e120a59e35b205f46e6e438- Fixture control
- corrected
- Service instance
p10demo2-job-timeout
Native record #0: original target run manifest
{
"adapter_abi": 1,
"adapter_id": "job-v1",
"attempt_id": "attempt1",
"builds": {
"binaries": {
"adapter": "d90e77e28be08e6dcbab2697586a5305b4b189365ab83425f43b0cd253d23c43",
"fixture": "4dcc02efab57872cc654358b4613342bf1c8eda716954da12209ef4813bded7c",
"runner": "2e33a3fb14996fca493117ff7429f4e91cb36887e0c595ffd2aae75cbc95e334",
"worker": "d90e77e28be08e6dcbab2697586a5305b4b189365ab83425f43b0cd253d23c43"
},
"compiler_variant": "gcc_ntox86_64",
"dirty": false,
"recipe_id": "6cb923cc6f93fb122c8d36d63a8359663681db0357d826d6890ea7ddbfdc254f",
"source_revision": "39b99d7a163c21c88d831456cc438e3c02a56ac9",
"source_tree_sha256": "08b20033edf22f6e0427b75b754a96d8f9fcdb358b8bbea51d224a4cc9e7e041"
},
"capabilities": [
"pending",
"unblock",
"state",
"release",
"health",
"timeout",
"signal",
"departure",
"error-probe",
"repeat",
"ordering",
"external-health"
],
"case_id": "timeout",
"cycle": 1,
"error_codes": {
"EINTR": 4,
"ENOENT": 2,
"EOK": 0,
"ETIMEDOUT": 260
},
"fixture_mode": "corrected",
"kind": "target-run-manifest",
"profile_sha256": "511cb8cc217ff0ced3df4d9ddf16e381118210845e120a59e35b205f46e6e438",
"run_id": "p10demo2-job-timeout",
"schema_version": 1,
"service_instance_id": "p10demo2-job-timeout",
"signal_codes": {
"SIGKILL": 9,
"SIGUSR1": 16
},
"suite_sha256": "9169e14cac8c48d8f9d095e4dbf21081feaea6f8a34298a388e14d06ff078ef3",
"target": {
"machine": "x86pc",
"priority": 10,
"release": "8.0.0",
"scheduling_policy": 2,
"sysname": "QNX",
"version": "2026/06/05-16:26:03EDT"
},
"tool_version": "0.3.0"
}Recorded QNX timeline
Zero-based JSONL event references. Offsets use this case's target monotonic clock. A configured deadline is not itself an observed expiry; these observations are not timing guarantees.
#1 · +0.0 mslab_controlsupervisor
{
"name": "none"
}#2 · +0.028 msrun_storagesupervisor
{
"run_id": "p10demo2-job-timeout"
}#3 · +0.05 mssettingssupervisor
{
"allowance_ms": 2000,
"case_ms": 10000,
"cleanup_ms": 2000,
"mode": "corrected",
"path": "/dev/resmgrcheck-job-p10demo2-job-timeout",
"timeout_ms": 500
}#4 · +2.99 msspawnedsupervisor
{
"binary": "job-v1-fixture",
"child_pid": "781053973",
"operation": "corrected"
}#5 · +17.07 msreadyfixture
{
"mode": "corrected",
"path": "/dev/resmgrcheck-job-p10demo2-job-timeout"
}#6 · +17.622 msphasesupervisor
{
"name": "ready"
}#7 · +19.313 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781062162",
"operation": "ready"
}#8 · +34.609 msstartedworker
{
"operation": "ready"
}#9 · +34.782 mscontrol_resultworker
{
"completed": 0,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 1
},
"generation": "1",
"operation": "ready",
"pending": 0,
"unblocks": 0
}#10 · +34.823 msclose_dupfixture
{
"client_pid": "781062162",
"ocb": 1,
"rcvid": "4612248972675776513",
"synthetic": 0
}#11 · +34.862 msclose_dup_defaultfixture
{
"ocb": 1,
"status": 0
}#12 · +34.882 msclose_ocbfixture
{
"ocb": 1
}#13 · +34.954 msclose_ocb_defaultfixture
{
"ocb": 1,
"status": 0
}#14 · +34.999 msclosedworker
{
"error": 0,
"rc": 0
}#15 · +35.069 msworker_finalworker
{
"exit_code": 0
}#16 · +35.97 msreapedsupervisor
{
"child_pid": "781062162",
"raw_status": 0
}#17 · +36.042 msprocess_exitsupervisor
{
"child_pid": "781062162",
"exit_code": 0,
"exited": 1,
"signal": 0
}#18 · +36.722 mswait_boundsupervisor
{
"child_pid": "781062162",
"deadline_ns": "38229847446504",
"operation": "ready",
"timed_out": 0
}#19 · +36.756 msphasesupervisor
{
"name": "normal"
}#20 · +39.711 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781070356",
"operation": "normal"
}#21 · +56.692 msstartedworker
{
"operation": "normal"
}#22 · +57.679 msreceivedfixture
{
"client_pid": "781070356",
"generation": "1",
"logical": "1",
"rcvid": "4612811922629197825"
}#23 · +57.765 mssamplefixture
{
"bytes": 16,
"generation": "1",
"logical": "1"
}#24 · +57.911 msclose_dupfixture
{
"client_pid": "781070356",
"ocb": 2,
"rcvid": "4613093397605908481",
"synthetic": 0
}#25 · +57.87 msresultworker
{
"api": "devctl",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "normal",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
}#26 · +57.934 msclose_dup_defaultfixture
{
"ocb": 2,
"status": 0
}#27 · +58.043 msclose_ocbfixture
{
"ocb": 2
}#28 · +58.563 msclose_ocb_defaultfixture
{
"ocb": 2,
"status": 0
}#29 · +58.984 msclosedworker
{
"error": 0,
"rc": 0
}#30 · +59.161 msworker_finalworker
{
"exit_code": 0
}#31 · +62.165 msreapedsupervisor
{
"child_pid": "781070356",
"raw_status": 0
}#32 · +62.208 msprocess_exitsupervisor
{
"child_pid": "781070356",
"exit_code": 0,
"exited": 1,
"signal": 0
}#33 · +63.539 mswait_boundsupervisor
{
"child_pid": "781070356",
"deadline_ns": "38229869656791",
"operation": "normal",
"timed_out": 0
}#34 · +63.576 msphasesupervisor
{
"name": "message"
}#35 · +66.963 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781078546",
"operation": "message"
}#36 · +84.567 msstartedworker
{
"operation": "message"
}#37 · +84.728 msreceivedfixture
{
"client_pid": "781078546",
"generation": "1",
"logical": "2",
"rcvid": "4613656347559329793"
}#38 · +84.759 mssamplefixture
{
"bytes": 16,
"generation": "1",
"logical": "2"
}#39 · +84.846 msclose_dupfixture
{
"client_pid": "781078546",
"ocb": 3,
"rcvid": "4613937822536040449",
"synthetic": 0
}#40 · +84.927 msclose_dup_defaultfixture
{
"ocb": 3,
"status": 0
}#41 · +85.033 msclose_ocbfixture
{
"ocb": 3
}#42 · +85.067 msclose_ocb_defaultfixture
{
"ocb": 3,
"status": 0
}#43 · +84.809 msresultworker
{
"api": "MsgSendv",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "message",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
}#44 · +85.281 msclosedworker
{
"error": 0,
"rc": 0
}#45 · +85.351 msworker_finalworker
{
"exit_code": 0
}#46 · +86.436 msreapedsupervisor
{
"child_pid": "781078546",
"raw_status": 0
}#47 · +86.469 msprocess_exitsupervisor
{
"child_pid": "781078546",
"exit_code": 0,
"exited": 1,
"signal": 0
}#48 · +87.136 mswait_boundsupervisor
{
"child_pid": "781078546",
"deadline_ns": "38229897355992",
"operation": "message",
"timed_out": 0
}#49 · +87.181 msphasesupervisor
{
"name": "negative"
}#50 · +88.777 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781082647",
"operation": "negative"
}#51 · +103.584 msstartedworker
{
"operation": "negative"
}#52 · +104.617 msresultworker
{
"api": "devctl",
"api_error": 2,
"error_name": "ENOENT",
"facts": {},
"normalized": "API_ERROR",
"operation": "negative",
"raw_errno": 0,
"raw_return": 2,
"result_shape": "integer-record"
}#53 · +104.673 msclose_dupfixture
{
"client_pid": "781082647",
"ocb": 4,
"rcvid": "4614782247466172417",
"synthetic": 0
}#54 · +104.702 msclose_dup_defaultfixture
{
"ocb": 4,
"status": 0
}#55 · +104.722 msclose_ocbfixture
{
"ocb": 4
}#56 · +104.786 msclose_ocb_defaultfixture
{
"ocb": 4,
"status": 0
}#57 · +104.815 msclosedworker
{
"error": 0,
"rc": 0
}#58 · +104.89 msworker_finalworker
{
"exit_code": 0
}#59 · +107.295 msreapedsupervisor
{
"child_pid": "781082647",
"raw_status": 0
}#60 · +107.337 msprocess_exitsupervisor
{
"child_pid": "781082647",
"exit_code": 0,
"exited": 1,
"signal": 0
}#61 · +109.654 mswait_boundsupervisor
{
"child_pid": "781082647",
"deadline_ns": "38229916442755",
"operation": "negative",
"timed_out": 0
}#62 · +109.7 msphasesupervisor
{
"name": "hold"
}#63 · +111.197 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781090834",
"operation": "hold"
}#64 · +125.313 msstartedworker
{
"operation": "hold"
}#65 · +125.715 msstate_changedfixture
{
"action": "submit",
"generation": "2"
}#66 · +125.816 msclose_dupfixture
{
"client_pid": "781090834",
"ocb": 5,
"rcvid": "4615626672396304385",
"synthetic": 0
}#67 · +125.784 mscontrol_resultworker
{
"completed": 0,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 0
},
"generation": "2",
"operation": "hold",
"pending": 0,
"unblocks": 0
}#68 · +125.841 msclose_dup_defaultfixture
{
"ocb": 5,
"status": 0
}#69 · +125.897 msclose_ocbfixture
{
"ocb": 5
}#70 · +125.949 msclose_ocb_defaultfixture
{
"ocb": 5,
"status": 0
}#71 · +126.019 msclosedworker
{
"error": 0,
"rc": 0
}#72 · +126.168 msworker_finalworker
{
"exit_code": 0
}#73 · +127.016 msreapedsupervisor
{
"child_pid": "781090834",
"raw_status": 0
}#74 · +127.047 msprocess_exitsupervisor
{
"child_pid": "781090834",
"exit_code": 0,
"exited": 1,
"signal": 0
}#75 · +127.26 mswait_boundsupervisor
{
"child_pid": "781090834",
"deadline_ns": "38229937800133",
"operation": "hold",
"timed_out": 0
}#76 · +128.696 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781094930",
"operation": "normal"
}#77 · +147.996 msstartedworker
{
"operation": "normal"
}#78 · +148.22 msreceivedfixture
{
"client_pid": "781094930",
"generation": "2",
"logical": "3",
"rcvid": "4616189622349725697"
}#79 · +148.249 msrequest_ocbfixture
{
"client_pid": "781094930",
"generation": "2",
"logical": "3",
"ocb": 6
}#80 · +148.323 mspendingfixture
{
"client_pid": "781094930",
"generation": "2",
"logical": "3",
"pending": 1,
"rcvid": "4616189622349725697"
}#81 · +148.835 msphasesupervisor
{
"name": "release"
}#82 · +149.829 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781094935",
"operation": "release"
}#83 · +165.232 msstartedworker
{
"operation": "release"
}#84 · +165.542 msterminal_attemptfixture
{
"action": "reply",
"error": 0,
"generation": "2",
"logical": "3",
"rc": 0,
"rcvid": "4616189622349725697"
}#85 · +165.636 msreleasedfixture
{
"generation": "2",
"logical": "3",
"rc": 0
}#86 · +165.662 msremovedfixture
{
"generation": "2",
"logical": "3",
"pending": 0,
"reason": "release"
}#87 · +165.713 msstate_changedfixture
{
"action": "complete",
"generation": "2"
}#88 · +165.732 msclose_dupfixture
{
"client_pid": "781094930",
"ocb": 6,
"rcvid": "4617034047279857665",
"synthetic": 0
}#89 · +165.771 msclose_dup_defaultfixture
{
"ocb": 6,
"status": 0
}#90 · +165.609 msresultworker
{
"api": "devctl",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "normal",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
}#91 · +166.192 msclosedworker
{
"error": 0,
"rc": 0
}#92 · +166.268 msworker_finalworker
{
"exit_code": 0
}#93 · +167.697 msreapedsupervisor
{
"child_pid": "781094930",
"raw_status": 0
}#94 · +167.803 msprocess_exitsupervisor
{
"child_pid": "781094930",
"exit_code": 0,
"exited": 1,
"signal": 0
}#95 · +167.836 msreapedsupervisor
{
"child_pid": "781094935",
"raw_status": 0
}#96 · +167.853 msprocess_exitsupervisor
{
"child_pid": "781094935",
"exit_code": 0,
"exited": 1,
"signal": 0
}#97 · +165.791 msclose_ocbfixture
{
"ocb": 6
}#98 · +165.918 msclose_ocb_defaultfixture
{
"ocb": 6,
"status": 0
}#99 · +166.059 msclose_dupfixture
{
"client_pid": "781094935",
"ocb": 7,
"rcvid": "4617315522256568322",
"synthetic": 0
}#100 · +166.215 msclose_dup_defaultfixture
{
"ocb": 7,
"status": 0
}#101 · +166.282 msclose_ocbfixture
{
"ocb": 7
}#102 · +166.594 msclose_ocb_defaultfixture
{
"ocb": 7,
"status": 0
}#103 · +165.752 mscontrol_resultworker
{
"completed": 0,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 1
},
"generation": "2",
"operation": "release",
"pending": 0,
"unblocks": 0
}#104 · +166.804 msclosedworker
{
"error": 0,
"rc": 0
}#105 · +167.014 msworker_finalworker
{
"exit_code": 0
}#106 · +168.774 mswait_boundsupervisor
{
"child_pid": "781094935",
"deadline_ns": "38229978018829",
"operation": "release",
"timed_out": 0
}#107 · +168.808 msphasesupervisor
{
"name": "hold"
}#108 · +169.718 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781103122",
"operation": "hold"
}#109 · +185.718 msstartedworker
{
"operation": "hold"
}#110 · +185.87 msstate_changedfixture
{
"action": "submit",
"generation": "3"
}#111 · +185.98 msclose_dupfixture
{
"client_pid": "781103122",
"ocb": 8,
"rcvid": "4618159947186700289",
"synthetic": 0
}#112 · +185.954 mscontrol_resultworker
{
"completed": 0,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 0
},
"generation": "3",
"operation": "hold",
"pending": 0,
"unblocks": 0
}#113 · +185.999 msclose_dup_defaultfixture
{
"ocb": 8,
"status": 0
}#114 · +186.13 msclose_ocbfixture
{
"ocb": 8
}#115 · +186.224 msclose_ocb_defaultfixture
{
"ocb": 8,
"status": 0
}#116 · +186.29 msclosedworker
{
"error": 0,
"rc": 0
}#117 · +186.36 msworker_finalworker
{
"exit_code": 0
}#118 · +187.25 msreapedsupervisor
{
"child_pid": "781103122",
"raw_status": 0
}#119 · +187.268 msprocess_exitsupervisor
{
"child_pid": "781103122",
"exit_code": 0,
"exited": 1,
"signal": 0
}#120 · +187.627 mswait_boundsupervisor
{
"child_pid": "781103122",
"deadline_ns": "38229998526704",
"operation": "hold",
"timed_out": 0
}#121 · +187.733 msstagesupervisor
{
"name": "deferred_release_complete"
}#122 · +188.603 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781107218",
"operation": "timed"
}#123 · +207.829 msstartedworker
{
"operation": "timed"
}#124 · +208.069 msreceivedfixture
{
"client_pid": "781107218",
"generation": "3",
"logical": "4",
"rcvid": "4618722897140121601"
}#125 · +208.236 msrequest_ocbfixture
{
"client_pid": "781107218",
"generation": "3",
"logical": "4",
"ocb": 9
}#126 · +208.264 mspendingfixture
{
"client_pid": "781107218",
"generation": "3",
"logical": "4",
"pending": 1,
"rcvid": "4618722897140121601"
}#127 · +208.024 msdeadlineworker
{
"deadline_ns": "38228521101602",
"operation": "timed",
"timeout_ms": 500
}#128 · +708.663 msunblockfixture
{
"generation": "3",
"live": 1,
"logical": "4",
"mode": "corrected",
"rcvid": "4618722897140121601"
}#129 · +708.722 msterminal_attemptfixture
{
"action": "cancel",
"error": 0,
"generation": "3",
"logical": "4",
"rc": 0,
"rcvid": "4618722897140121601"
}#130 · +710.158 mscancel_completedfixture
{
"error": 0,
"generation": "3",
"logical": "4",
"rc": 0
}#131 · +710.246 msremovedfixture
{
"generation": "3",
"logical": "4",
"pending": 0,
"reason": "cancellation"
}#132 · +710.282 msclose_dupfixture
{
"client_pid": "781107218",
"ocb": 9,
"rcvid": "4619004372116832257",
"synthetic": 0
}#133 · +710.306 msclose_dup_defaultfixture
{
"ocb": 9,
"status": 0
}#134 · +710.734 msclose_ocbfixture
{
"ocb": 9
}#135 · +709.491 msresultworker
{
"api": "MsgSendv",
"api_error": 260,
"error_name": "ETIMEDOUT",
"facts": {},
"normalized": "TIMEOUT",
"operation": "timed",
"raw_errno": 260,
"raw_return": -1,
"result_shape": "integer-record"
}#136 · +710.919 msclosedworker
{
"error": 0,
"rc": 0
}#137 · +711.042 msworker_finalworker
{
"exit_code": 0
}#138 · +712.32 msreapedsupervisor
{
"child_pid": "781107218",
"raw_status": 0
}#139 · +712.35 msprocess_exitsupervisor
{
"child_pid": "781107218",
"exit_code": 0,
"exited": 1,
"signal": 0
}#140 · +712.684 msoperation_boundsupervisor
{
"completion_bound_ns": "38230521101602",
"expired": 0,
"result_observed": 1,
"worker_reaped": 1
}#141 · +712.72 msphasesupervisor
{
"name": "state"
}#142 · +715.864 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781185042",
"operation": "state"
}#143 · +710.798 msclose_ocb_defaultfixture
{
"ocb": 9,
"status": 0
}#144 · +736.284 msstartedworker
{
"operation": "state"
}#145 · +736.534 mscontrol_resultworker
{
"completed": 1,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 0
},
"generation": "3",
"operation": "state",
"pending": 0,
"unblocks": 1
}#146 · +736.655 msclose_dupfixture
{
"client_pid": "781185042",
"ocb": 10,
"rcvid": "4619848797046964225",
"synthetic": 0
}#147 · +736.686 msclose_dup_defaultfixture
{
"ocb": 10,
"status": 0
}#148 · +736.707 msclose_ocbfixture
{
"ocb": 10
}#149 · +736.786 msclose_ocb_defaultfixture
{
"ocb": 10,
"status": 0
}#150 · +736.815 msclosedworker
{
"error": 0,
"rc": 0
}#151 · +736.965 msworker_finalworker
{
"exit_code": 0
}#152 · +738.017 msreapedsupervisor
{
"child_pid": "781185042",
"raw_status": 0
}#153 · +738.042 msprocess_exitsupervisor
{
"child_pid": "781185042",
"exit_code": 0,
"exited": 1,
"signal": 0
}#154 · +738.549 mswait_boundsupervisor
{
"child_pid": "781185042",
"deadline_ns": "38230546919427",
"operation": "state",
"timed_out": 0
}#155 · +738.619 msphasesupervisor
{
"name": "release"
}#156 · +742.186 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781189138",
"operation": "release"
}#157 · +761.939 msstartedworker
{
"operation": "release"
}#158 · +762.318 msstate_changedfixture
{
"action": "complete",
"generation": "3"
}#159 · +762.938 msclose_dupfixture
{
"client_pid": "781189138",
"ocb": 11,
"rcvid": "4620693221977096193",
"synthetic": 0
}#160 · +762.885 mscontrol_resultworker
{
"completed": 1,
"error": 0,
"facts": {
"job_exists": 1,
"job_ready": 1
},
"generation": "3",
"operation": "release",
"pending": 0,
"unblocks": 1
}#161 · +763.139 msclose_dup_defaultfixture
{
"ocb": 11,
"status": 0
}#162 · +763.246 msclose_ocbfixture
{
"ocb": 11
}#163 · +763.586 msclose_ocb_defaultfixture
{
"ocb": 11,
"status": 0
}#164 · +763.715 msclosedworker
{
"error": 0,
"rc": 0
}#165 · +763.791 msworker_finalworker
{
"exit_code": 0
}#166 · +764.878 msreapedsupervisor
{
"child_pid": "781189138",
"raw_status": 0
}#167 · +764.906 msprocess_exitsupervisor
{
"child_pid": "781189138",
"exit_code": 0,
"exited": 1,
"signal": 0
}#168 · +765.288 mswait_boundsupervisor
{
"child_pid": "781189138",
"deadline_ns": "38230574127105",
"operation": "release",
"timed_out": 0
}#169 · +765.324 msphasesupervisor
{
"name": "health"
}#170 · +767.607 msspawnedsupervisor
{
"binary": "worker",
"child_pid": "781193234",
"operation": "health"
}#171 · +787.292 msstartedworker
{
"operation": "health"
}#172 · +787.749 msreceivedfixture
{
"client_pid": "781193234",
"generation": "3",
"logical": "5",
"rcvid": "4621256171930517505"
}#173 · +787.894 mssamplefixture
{
"bytes": 16,
"generation": "3",
"logical": "5"
}#174 · +788.158 msclose_dupfixture
{
"client_pid": "781193234",
"ocb": 12,
"rcvid": "4621537646907228161",
"synthetic": 0
}#175 · +788.229 msclose_dup_defaultfixture
{
"ocb": 12,
"status": 0
}#176 · +788.281 msclose_ocbfixture
{
"ocb": 12
}#177 · +788.324 msclose_ocb_defaultfixture
{
"ocb": 12,
"status": 0
}#178 · +788.007 msresultworker
{
"api": "devctl",
"api_error": 0,
"error_name": "EOK",
"facts": {
"job_id": 1,
"value": 420
},
"normalized": "OK",
"operation": "health",
"raw_errno": 0,
"raw_return": 0,
"result_shape": "integer-record"
}#179 · +788.669 msclosedworker
{
"error": 0,
"rc": 0
}#180 · +788.753 msworker_finalworker
{
"exit_code": 0
}#181 · +791.163 msreapedsupervisor
{
"child_pid": "781193234",
"raw_status": 0
}#182 · +791.196 msprocess_exitsupervisor
{
"child_pid": "781193234",
"exit_code": 0,
"exited": 1,
"signal": 0
}#183 · +791.852 mswait_boundsupervisor
{
"child_pid": "781193234",
"deadline_ns": "38230597327252",
"operation": "health",
"timed_out": 0
}#184 · +791.885 msphasesupervisor
{
"name": "cleanup"
}#185 · +791.904 msfixture_stopsupervisor
{
"blocked_worker_reaped": 1,
"child_pid": "781053973"
}#186 · +791.98 mssignal_sentsupervisor
{
"child_pid": "781053973",
"error": 0,
"rc": 0,
"signal": 15
}#187 · +792.942 msreapedsupervisor
{
"child_pid": "781053973",
"raw_status": 15
}#188 · +792.98 msprocess_exitsupervisor
{
"child_pid": "781053973",
"exit_code": 0,
"exited": 0,
"signal": 15
}#189 · +793.124 mscleanupsupervisor
{
"all_reaped": 1,
"evidence_error": 0
}#190 · +808.159 msrun_finalsupervisor
{
"cleanup_ok": 1,
"evidence_error": 0,
"flow_complete": 1
}