WVMQWENWS_6D91C42F
source=WEBVM
time=2026-11-08T16:09:22+00:00
stage=PI_HEARTBEAT
15:59:49+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-io-loop-run/kernel"], "duration_ms": 25676.364, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel version 21 successfully pushed.  Please check progress at https://www.kaggle.com/code/simonday/webvm-io-loop-proof\n", "time": "2026-11-08T15:59:49.304+00:00"}
[2026-11-08T15:59:51+00:00] IO_LOOP_CONTROLLER {"event": "KERNEL_SUBMITTED", "kernel_id": "simonday/webvm-io-loop-proof", "time": "2026-11-08T15:59:49.325+00:00"}
[2026-11-08T15:59:51+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T15:59:49.418+00:00", "timeout_seconds": 60}
[2026-11-08T16:00:14+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "duration_ms": 24783.891, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.RUNNING\"\n", "time": "2026-11-08T16:00:14.203+00:00"}
[2026-11-08T16:00:15+00:00] IO_LOOP_CONTROLLER {"event": "EXECUTION_STATUS", "exit_code": 0, "kernel_id": "simonday/webvm-io-loop-proof", "status": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.RUNNING\"", "time": "2026-11-08T16:00:14.216+00:00"}
[2026-11-08T16:00:24+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:00:24.243+00:00", "timeout_seconds": 60}
[2026-11-08T16:00:48+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "duration_ms": 24036.485, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.RUNNING\"\n", "time": "2026-11-08T16:00:48.280+00:00"}
[2026-11-08T16:00:50+00:00] IO_LOOP_CONTROLLER {"event": "EXECUTION_STATUS", "exit_code": 0, "kernel_id": "simonday/webvm-io-loop-proof", "status": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.RUNNING\"", "time": "2026-11-08T16:00:48.286+00:00"}
[2026-11-08T16:00:58+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:00:58.355+00:00", "timeout_seconds": 60}
[2026-11-08T16:01:21+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "duration_ms": 23555.3, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.COMPLETE\"\n", "time": "2026-11-08T16:01:21.914+00:00"}
[2026-11-08T16:01:24+00:00] IO_LOOP_CONTROLLER {"event": "EXECUTION_STATUS", "exit_code": 0, "kernel_id": "simonday/webvm-io-loop-proof", "status": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.COMPLETE\"", "time": "2026-11-08T16:01:21.933+00:00"}
[2026-11-08T16:01:26+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "output", "simonday/webvm-io-loop-proof", "-p", "/home/user/kaggle-io-loop-run/output", "-o", "--file-pattern", "^tx_response\\.json$"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:01:22.089+00:00", "timeout_seconds": 300}
[2026-11-08T16:01:49+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "output", "simonday/webvm-io-loop-proof", "-p", "/home/user/kaggle-io-loop-run/output", "-o", "--file-pattern", "^tx_response\\.json$"], "duration_ms": 26961.165, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Downloading tx_response.json to /home/user/kaggle-io-loop-run/output\n\n  0%|          | 0.00/1.96k [00:00<?, ?B/s]\n100%|██████████| 1.96k/1.96k [00:00<00:00, 26.5kB/s]\n\nOutput file downloaded to /home/user/kaggle-io-loop-run/output/tx_response.json\nKernel log downloaded to /home/user/kaggle-io-loop-run/output/webvm-io-loop-proof.log \n", "time": "2026-11-08T16:01:49.045+00:00"}
[2026-11-08T16:01:53+00:00] IO_LOOP_CONTROLLER {"checks": {"ack_state": true, "execution_not_timed_out": true, "execution_succeeded": true, "payload": true, "payload_length": true, "received_checksum": true, "request_id": true, "sequence": true, "version": true}, "event": "OUTPUT_VALIDATION", "response": {"ack_state": "processed_once", "agent_elapsed_ms": 41827.452, "execution": {"elapsed_ms": 27159.17, "exit_code": 0, "output": "REMOTE_PROBE_RESULT {\"firewall_changed\": false, \"hostname\": \"f57a065da2ed\", \"https_example\": {\"error\": \"ProbeTimeout\", \"ok\": false}, \"jupyter_8888_untouched\": true, \"network\": [{\"dns_or_tcp\": false, \"error\": \"ProbeTimeout\", \"host\": \"raw.githubusercontent.com\", \"port\": 443}, {\"dns_or_tcp\": false, \"error\": \"ProbeTimeout\", \"host\": \"api.kaggle.com\", \"port\": 443}, {\"dns_or_tcp\": false, \"error\": \"ProbeTimeout\", \"host\": \"kkb-production.jupyter-proxy.kaggle.net\", \"port\": 443}, {\"dns_or_tcp\": false, \"error\": \"ProbeTimeout\", \"host\": \"pste.us\", \"port\": 443}], \"probe\": \"webvm-rx-tx-remote-probe-v2\", \"time\": 1794153607.158412, \"uid\": 0}\n", "sha256": "dbf9c23bc664229dba3021bdb7c0f82dd6078441eb55b64f4f66f3b28d3bed72", "timed_out": false}, "network_diagnostics": {"dev_net_tun": false, "iptables_available": false, "ipv4_forwarding": "1", "jupyter_proxy_kernel_id": null, "jupyter_proxy_route_found": false, "jupyter_proxy_token_present": false, "outbound_tcp_443": {"kkb-production.jupyter-proxy.kaggle.net": {"dns_or_tcp": false, "error": "ProbeTimeout"}, "pste.us": {"dns_or_tcp": false, "error": "ProbeTimeout"}}, "port_8889_listening": false, "tailscale_available": false, "tailscaled_available": false, "uid": 0}, "payload": "EXEC:dbf9c23bc664229dba3021bdb7c0f82dd6078441eb55b64f4f66f3b28d3bed72:0", "payload_length": 71, "received_at": "2026-11-08T16:00:46.234+00:00", "received_checksum": "99074b5761f46db05ad53640dba7f035739f428df18578c850dd0bc04b8e690c", "request_id": "io-loop-proof-20261108T155720250929Z", "sequence": 1, "type": "ack", "version": 1}, "time": "2026-11-08T16:01:49.079+00:00"}
[2026-11-08T16:01:55+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "output", "simonday/webvm-io-loop-proof", "-p", "/home/user/kaggle-io-loop-run/output/notebook_diagnostics", "-o", "--file-pattern", "^io_loop_proof\\.ipynb$"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:01:49.093+00:00", "timeout_seconds": 180}
[2026-11-08T16:02:14+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "output", "simonday/webvm-io-loop-proof", "-p", "/home/user/kaggle-io-loop-run/output/notebook_diagnostics", "-o", "--file-pattern", "^io_loop_proof\\.ipynb$"], "duration_ms": 25067.69, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel log downloaded to /home/user/kaggle-io-loop-run/output/notebook_diagnostics/webvm-io-loop-proof.log \n", "time": "2026-11-08T16:02:14.161+00:00"}
[2026-11-08T16:02:16+00:00] IO_LOOP_CONTROLLER {"event": "NOTEBOOK_DIAGNOSTIC_DOWNLOAD", "exit_code": 0, "files": [], "output_tail": "Kernel log downloaded to /home/user/kaggle-io-loop-run/output/notebook_diagnostics/webvm-io-loop-proof.log \n", "time": "2026-11-08T16:02:14.183+00:00"}
[2026-11-08T16:02:16+00:00] IO_LOOP_CONTROLLER {"event": "PROXY_DIAGNOSTIC_RESULTS", "found": false, "line_count": 0, "lines": [], "time": "2026-11-08T16:02:14.185+00:00"}
[2026-11-08T16:02:16+00:00] IO_LOOP_CONTROLLER {"event": "LOOP_PROOF_PASS", "output_bytes": 2006, "output_file": "/home/user/kaggle-io-loop-run/output/tx_response.json", "payload_bytes": 3644, "request_id": "io-loop-proof-20261108T155720250929Z", "round_trip_ms": 294043.69, "rx_checksum": "99074b5761f46db05ad53640dba7f035739f428df18578c850dd0bc04b8e690c", "sequence": 1, "time": "2026-11-08T16:02:14.187+00:00", "tx_checksum": "e8dd3931f102ef80c300f1cd6a3e80bc4d6f1b23e6919e034711e3a48c016831"}
[2026-11-08T16:02:18+00:00] LOOP_PROOF_PASS output=/home/user/kaggle-io-loop-run/output/tx_response.json log=/home/user/kaggle-io-loop-run/run.jsonl
[2026-11-08T16:02:20+00:00] IO_LOOP_CONTROLLER_EXIT returncode=0
[2026-11-08T16:02:22+00:00] RX_TX_CURRENT_DEPLOYMENT_PROOF_PASS transport=kaggle-api-dataset-and-kernel-output
[2026-11-08T16:02:22+00:00] TCP_LINK_CONTROLLER_START kernel_id=simonday/webvm-tcp-link
[2026-11-08T16:02:22+00:00] IO_LOOP_CONTROLLER {"dataset_id": "simonday/webvm-io-loop-rx", "event": "RUN_BEGIN", "kernel_id": "simonday/webvm-tcp-link", "poll_seconds": 10, "time": "2026-11-08T16:02:17.615+00:00", "timeout_seconds": 900}
[2026-11-08T16:02:22+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:02:17.624+00:00", "timeout_seconds": 20}
[2026-11-08T16:02:39+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 21850.879, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:02:39.491+00:00"}
[2026-11-08T16:02:39+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:02:39.499+00:00", "timeout_seconds": 20}
[2026-11-08T16:03:01+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 21570.026, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:03:01.070+00:00"}
[2026-11-08T16:03:03+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 43456.49, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:03:01.078+00:00"}
[2026-11-08T16:03:03+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_PREDEPLOY_STATUS_UNKNOWN", "kernel_id": "simonday/webvm-tcp-link", "note": "Continuing with the explicit deployment request", "time": "2026-11-08T16:03:01.081+00:00"}
[2026-11-08T16:03:03+00:00] IO_LOOP_CONTROLLER {"event": "POC_FILES_WRITTEN", "notebook_bytes": 7290, "service": "plain-python-tcp-echo-listener", "time": "2026-11-08T16:03:01.557+00:00"}
[2026-11-08T16:03:03+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-tcp-link-run/kernel"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:03:01.567+00:00", "timeout_seconds": 300}
[2026-11-08T16:03:26+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-tcp-link-run/kernel"], "duration_ms": 24792.716, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel version 21 successfully pushed.  Please check progress at https://www.kaggle.com/code/simonday/webvm-tcp-link\n", "time": "2026-11-08T16:03:26.360+00:00"}
[2026-11-08T16:03:28+00:00] IO_LOOP_CONTROLLER {"event": "KERNEL_SUBMITTED", "kernel_id": "simonday/webvm-tcp-link", "time": "2026-11-08T16:03:26.366+00:00"}
[2026-11-08T16:03:28+00:00] IO_LOOP_CONTROLLER {"event": "TCP_LINK_KERNEL_SUBMITTED", "kernel_id": "simonday/webvm-tcp-link", "local_port": 8889, "service": "plain-python-tcp-echo-listener", "time": "2026-11-08T16:03:26.367+00:00", "wait_for_completion": false}
[2026-11-08T16:03:28+00:00] TCP_LINK_KERNEL_SUBMITTED kernel_id=simonday/webvm-tcp-link local_port=8889 service=plain-python-tcp-echo-listener
[2026-11-08T16:03:28+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:03:26.372+00:00", "timeout_seconds": 15}
[2026-11-08T16:03:41+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15347.821, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:03:41.722+00:00"}
[2026-11-08T16:03:41+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:03:41.727+00:00", "timeout_seconds": 15}
[2026-11-08T16:03:57+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15346.88, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:03:57.075+00:00"}
[2026-11-08T16:03:57+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30709.695, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:03:57.080+00:00"}
[2026-11-08T16:03:57+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:03:57.082+00:00", "waited_seconds": 30.7}
[2026-11-08T16:04:02+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:04:02.177+00:00", "timeout_seconds": 15}
[2026-11-08T16:04:17+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15352.1, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:04:17.527+00:00"}
[2026-11-08T16:04:19+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:04:17.533+00:00", "timeout_seconds": 15}
[2026-11-08T16:04:33+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15312.784, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:04:32.855+00:00"}
[2026-11-08T16:04:33+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30747.454, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:04:32.867+00:00"}
[2026-11-08T16:04:33+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:04:32.872+00:00", "waited_seconds": 66.5}
[2026-11-08T16:04:37+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:04:37.889+00:00", "timeout_seconds": 15}
[2026-11-08T16:04:55+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 17600.916, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:04:55.493+00:00"}
[2026-11-08T16:04:55+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:04:55.499+00:00", "timeout_seconds": 15}
[2026-11-08T16:05:11+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15351.92, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:05:10.862+00:00"}
[2026-11-08T16:05:11+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 33009.5, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:05:10.895+00:00"}
[2026-11-08T16:05:11+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:05:10.904+00:00", "waited_seconds": 104.5}
[2026-11-08T16:05:16+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:05:15.925+00:00", "timeout_seconds": 15}
[2026-11-08T16:05:31+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15246.576, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:05:31.175+00:00"}
[2026-11-08T16:05:35+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:05:31.184+00:00", "timeout_seconds": 15}
[2026-11-08T16:05:46+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15293.185, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:05:46.486+00:00"}
[2026-11-08T16:05:46+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30577.46, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:05:46.492+00:00"}
[2026-11-08T16:05:46+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:05:46.499+00:00", "waited_seconds": 140.1}
[2026-11-08T16:05:51+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:05:51.506+00:00", "timeout_seconds": 15}
[2026-11-08T16:06:07+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15316.741, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:06:06.825+00:00"}
[2026-11-08T16:06:07+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:06:06.835+00:00", "timeout_seconds": 15}
[2026-11-08T16:06:22+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15383.935, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:06:22.235+00:00"}
[2026-11-08T16:06:22+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30756.951, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:06:22.261+00:00"}
[2026-11-08T16:06:22+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:06:22.277+00:00", "waited_seconds": 175.9}
[2026-11-08T16:06:27+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:06:27.293+00:00", "timeout_seconds": 15}
[2026-11-08T16:06:44+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 16994.62, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:06:44.290+00:00"}
[2026-11-08T16:06:48+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:06:44.297+00:00", "timeout_seconds": 15}
[2026-11-08T16:06:59+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15322.52, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:06:59.641+00:00"}
[2026-11-08T16:06:59+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 32382.516, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:06:59.666+00:00"}
[2026-11-08T16:06:59+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:06:59.671+00:00", "waited_seconds": 213.3}
[2026-11-08T16:07:04+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:07:04.689+00:00", "timeout_seconds": 15}
[2026-11-08T16:07:20+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15259.921, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:07:19.967+00:00"}
[2026-11-08T16:07:20+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:07:19.980+00:00", "timeout_seconds": 15}
[2026-11-08T16:07:35+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15376.905, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:07:35.371+00:00"}
[2026-11-08T16:07:35+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30726.766, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:07:35.405+00:00"}
[2026-11-08T16:07:35+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:07:35.411+00:00", "waited_seconds": 249.0}
[2026-11-08T16:07:40+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:07:40.437+00:00", "timeout_seconds": 15}
[2026-11-08T16:07:56+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15221.625, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:07:55.662+00:00"}
[2026-11-08T16:08:00+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:07:55.666+00:00", "timeout_seconds": 15}
[2026-11-08T16:08:12+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 17220.431, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:08:12.896+00:00"}
[2026-11-08T16:08:12+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 32479.054, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:08:12.906+00:00"}
[2026-11-08T16:08:12+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:08:12.910+00:00", "waited_seconds": 286.5}
[2026-11-08T16:08:17+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:08:17.919+00:00", "timeout_seconds": 15}
[2026-11-08T16:08:34+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 16137.221, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:08:34.059+00:00"}
[2026-11-08T16:08:34+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "event": "API_REQUEST_START", "proxy_vars_removed": true, "time": "2026-11-08T16:08:34.064+00:00", "timeout_seconds": 15}
[2026-11-08T16:08:49+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15291.161, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:08:49.369+00:00"}
[2026-11-08T16:08:49+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 31482.241, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:08:49.399+00:00"}
[2026-11-08T16:08:49+00:00] IO_LOOP_CONTROLLER {"error": "Kaggle read-only API command timed out in configured and proxy-bypass attempts: kaggle kernels status simonday/webvm-tcp-link", "event": "TCP_LINK_STATUS_POLL_TIMEOUT", "kernel_id": "simonday/webvm-tcp-link", "note": "Retrying until the startup deadline instead of aborting the controller", "time": "2026-11-08T16:08:49.404+00:00", "waited_seconds": 323.0}
[2026-11-08T16:08:54+00:00] IO_LOOP_CONTROLLER {"event": "TCP_LINK_STARTUP_PENDING", "kernel_id": "simonday/webvm-tcp-link", "status_tail": "", "time": "2026-11-08T16:08:54.408+00:00", "waited_seconds": 328.0}
[2026-11-08T16:08:54+00:00] TCP_LINK_STARTUP_PENDING kernel_id=simonday/webvm-tcp-link
[2026-11-08T16:08:54+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "output", "simonday/webvm-tcp-link", "-p", "/home/user/kaggle-tcp-link-run/output/tcp_link_status_pending", "-o", "--file-pattern", "^tcp_link_status[.]json$"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-08T16:08:54.440+00:00", "timeout_seconds": 45}
[2026-11-08T16:09:19+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "output", "simonday/webvm-tcp-link", "-p", "/home/user/kaggle-tcp-link-run/output/tcp_link_status_pending", "-o", "--file-pattern", "^tcp_link_status[.]json$"], "duration_ms": 24841.694, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Downloading tcp_link_status.json to /home/user/kaggle-tcp-link-run/output/tcp_link_status_pending\n\n  0%|          | 0.00/130 [00:00<?, ?B/s]\n100%|██████████| 130/130 [00:00<00:00, 2.69kB/s]\n\nOutput file downloaded to /home/user/kaggle-tcp-link-run/output/tcp_link_status_pending/tcp_link_status.json\nKernel log downloaded to /home/user/kaggle-tcp-link-run/output/tcp_link_status_pending/webvm-tcp-link.log \n", "time": "2026-11-08T16:09:19.282+00:00"}