WVMQWENWS_6D91C42F source=WEBVM time=2026-11-08T17:53:11+00:00 stage=PI_WRAPPER_FINISHED stdout\": \"Linux e3a627f0f707 6.18.55+ #1 SMP Thu Oct 22 16:37:21 UTC 2026 x86_64 x86_64 x86_64 GNU/Linux\\n\"}, \"netfilter_modules_loaded\": [\"nft_chain_nat\", \"nf_nat\", \"nf_tables\"], \"proc_ip_tables_names\": \"\"}, \"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-v3\", \"time\": 1794156026.536921, \"uid\": 0}\n", "sha256": "623504b7c22661357f43a1f04cba452b0062aec4fe446b1f4a9524f63738ba16", "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:623504b7c22661357f43a1f04cba452b0062aec4fe446b1f4a9524f63738ba16:0", "payload_length": 71, "received_at": "2026-11-08T16:41:07.733+00:00", "received_checksum": "8ad4329d0161b5e32dad6410fae6df5ec446fa5f206a657e2bc6bb8a6f69fa29", "request_id": "io-loop-proof-20261108T163814832134Z", "sequence": 1, "type": "ack", "version": 1}, "time": "2026-11-08T16:42:04.325+00:00"} [2026-11-08T16:42:09+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:42:04.411+00:00", "timeout_seconds": 180} [2026-11-08T16:42:27+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": 22830.875, "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:42:27.243+00:00"} [2026-11-08T16:42:29+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:42:27.268+00:00"} [2026-11-08T16:42:29+00:00] IO_LOOP_CONTROLLER {"event": "PROXY_DIAGNOSTIC_RESULTS", "found": false, "line_count": 0, "lines": [], "time": "2026-11-08T16:42:27.270+00:00"} [2026-11-08T16:42:29+00:00] IO_LOOP_CONTROLLER {"event": "LOOP_PROOF_PASS", "output_bytes": 2966, "output_file": "/home/user/kaggle-io-loop-run/output/tx_response.json", "payload_bytes": 6856, "request_id": "io-loop-proof-20261108T163814832134Z", "round_trip_ms": 252623.755, "rx_checksum": "8ad4329d0161b5e32dad6410fae6df5ec446fa5f206a657e2bc6bb8a6f69fa29", "sequence": 1, "time": "2026-11-08T16:42:27.272+00:00", "tx_checksum": "794112f7c99df1aa5e9625f52e3d05a88f084f5640ac95f4840d68758feb265a"} [2026-11-08T16:42:32+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:42:34+00:00] IO_LOOP_CONTROLLER_EXIT returncode=0 [2026-11-08T16:42:36+00:00] RX_TX_CURRENT_DEPLOYMENT_PROOF_PASS transport=kaggle-api-dataset-and-kernel-output [2026-11-08T16:42:36+00:00] TCP_LINK_CONTROLLER_START kernel_id=simonday/webvm-tcp-link [2026-11-08T16:42:36+00:00] TCP_LINK_CONTROLLER_BACKGROUND_STARTED command_channel=unblocked [2026-11-08T16:42:36+00:00] RX_TX_REMOTE_COMMAND_POLL_STARTED interval_seconds=30 current_sha256=623504b7c22661357f43a1f04cba452b0062aec4fe446b1f4a9524f63738ba16 [2026-11-08T16:42:36+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:42:30.981+00:00", "timeout_seconds": 900} [2026-11-08T16:42:36+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:42:31.002+00:00", "timeout_seconds": 20} [2026-11-08T16:42:53+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 22165.036, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:42:53.181+00:00"} [2026-11-08T16:42: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:42:53.186+00:00", "timeout_seconds": 20} [2026-11-08T16:43:17+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 24532.9, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:43:17.721+00:00"} [2026-11-08T16:43:17+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 46737.935, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:43:17.731+00:00"} [2026-11-08T16:43:17+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:43:17.734+00:00"} [2026-11-08T16:43:18+00:00] IO_LOOP_CONTROLLER {"event": "POC_FILES_WRITTEN", "notebook_bytes": 7290, "service": "plain-python-tcp-echo-listener", "time": "2026-11-08T16:43:17.998+00:00"} [2026-11-08T16:43:18+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:43:18.001+00:00", "timeout_seconds": 300} [2026-11-08T16:43:42+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-tcp-link-run/kernel"], "duration_ms": 24538.76, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel version 23 successfully pushed. Please check progress at https://www.kaggle.com/code/simonday/webvm-tcp-link\n", "time": "2026-11-08T16:43:42.540+00:00"} [2026-11-08T16:43:45+00:00] IO_LOOP_CONTROLLER {"event": "KERNEL_SUBMITTED", "kernel_id": "simonday/webvm-tcp-link", "time": "2026-11-08T16:43:42.546+00:00"} [2026-11-08T16:43:45+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:43:42.548+00:00", "wait_for_completion": false} [2026-11-08T16:43:45+00:00] TCP_LINK_KERNEL_SUBMITTED kernel_id=simonday/webvm-tcp-link local_port=8889 service=plain-python-tcp-echo-listener [2026-11-08T16:43:45+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:43:42.554+00:00", "timeout_seconds": 15} [2026-11-08T16:43:57+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15279.931, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:43:57.836+00:00"} [2026-11-08T16:44: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:43:57.841+00:00", "timeout_seconds": 15} [2026-11-08T16:44:13+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15974.044, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:44:13.816+00:00"} [2026-11-08T16:44:13+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 31268.14, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:44:13.820+00:00"} [2026-11-08T16:44:13+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:44:13.822+00:00", "waited_seconds": 31.3} [2026-11-08T16:44:19+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:44:18.931+00:00", "timeout_seconds": 15} [2026-11-08T16:44:35+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 16033.265, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:44:34.963+00:00"} [2026-11-08T16:44: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:44:34.971+00:00", "timeout_seconds": 15} [2026-11-08T16:44:50+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15322.869, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:44:50.301+00:00"} [2026-11-08T16:44:50+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 31447.524, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:44:50.310+00:00"} [2026-11-08T16:44:50+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:44:50.315+00:00", "waited_seconds": 67.8} [2026-11-08T16:44:55+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:44:55.330+00:00", "timeout_seconds": 15} [2026-11-08T16:45:11+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15238.944, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:45:10.573+00:00"} [2026-11-08T16:45:15+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:45:10.580+00:00", "timeout_seconds": 15} [2026-11-08T16:45:26+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15335.6, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:45:25.926+00:00"} [2026-11-08T16:45:26+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30634.079, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:45:25.961+00:00"} [2026-11-08T16:45:26+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:45:25.971+00:00", "waited_seconds": 103.4} [2026-11-08T16:45:31+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:45:30.987+00:00", "timeout_seconds": 15} [2026-11-08T16:45:46+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15250.094, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:45:46.240+00:00"} [2026-11-08T16:45:46+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:45:46.249+00:00", "timeout_seconds": 15} [2026-11-08T16:46:01+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15255.665, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:46:01.515+00:00"} [2026-11-08T16:46:01+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30546.605, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:46:01.524+00:00"} [2026-11-08T16:46:01+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:46:01.527+00:00", "waited_seconds": 139.0} [2026-11-08T16:46:06+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:46:06.534+00:00", "timeout_seconds": 15} [2026-11-08T16:46:22+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15286.471, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:46:21.827+00:00"} [2026-11-08T16:46:27+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:46:21.837+00:00", "timeout_seconds": 15} [2026-11-08T16:46:37+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15447.161, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:46:37.298+00:00"} [2026-11-08T16:46:37+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30794.506, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:46:37.326+00:00"} [2026-11-08T16:46:37+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:46:37.347+00:00", "waited_seconds": 174.8} [2026-11-08T16:46:42+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:46:42.380+00:00", "timeout_seconds": 15} [2026-11-08T16:46:57+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15299.315, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:46:57.684+00:00"} [2026-11-08T16:46:57+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:46:57.695+00:00", "timeout_seconds": 15} [2026-11-08T16:47:13+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15298.685, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:47:13.020+00:00"} [2026-11-08T16:47:13+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30664.355, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:47:13.035+00:00"} [2026-11-08T16:47:13+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:47:13.048+00:00", "waited_seconds": 210.5} [2026-11-08T16:47:18+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:47:18.068+00:00", "timeout_seconds": 15} [2026-11-08T16:47:33+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15257.715, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:47:33.343+00:00"} [2026-11-08T16:47:37+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:47:33.358+00:00", "timeout_seconds": 15} [2026-11-08T16:47:48+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15430.49, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:47:48.803+00:00"} [2026-11-08T16:47:48+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 30778.11, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:47:48.835+00:00"} [2026-11-08T16:47:48+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:47:48.842+00:00", "waited_seconds": 246.3} [2026-11-08T16:47:53+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:47:53.862+00:00", "timeout_seconds": 15} [2026-11-08T16:48:09+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15214.515, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:48:09.081+00:00"} [2026-11-08T16:48:09+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:48:09.087+00:00", "timeout_seconds": 15} [2026-11-08T16:48:26+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 16798.651, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:48:25.894+00:00"} [2026-11-08T16:48:26+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 32049.716, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:48:25.902+00:00"} [2026-11-08T16:48:26+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:48:25.905+00:00", "waited_seconds": 283.4} [2026-11-08T16:48:30+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:48:30.919+00:00", "timeout_seconds": 15} [2026-11-08T16:48:47+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15917.02, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:48:46.839+00:00"} [2026-11-08T16:48:51+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:48:46.843+00:00", "timeout_seconds": 15} [2026-11-08T16:49:02+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 15344.295, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T16:49:02.203+00:00"} [2026-11-08T16:49:02+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 31321.821, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T16:49:02.239+00:00"} [2026-11-08T16:49:02+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:49:02.244+00:00", "waited_seconds": 319.7} [2026-11-08T16:49:07+00:00] IO_LOOP_CONTROLLER {"event": "TCP_LINK_STARTUP_PENDING", "kernel_id": "simonday/webvm-tcp-link", "status_tail": "", "time": "2026-11-08T16:49:07.285+00:00", "waited_seconds": 324.7} [2026-11-08T16:49:07+00:00] TCP_LINK_STARTUP_PENDING kernel_id=simonday/webvm-tcp-link [2026-11-08T16:49:07+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:49:07.317+00:00", "timeout_seconds": 45} [2026-11-08T16:49:33+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": 26373.375, "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 [2026-11-08T17:53:10+00:00] main() [2026-11-08T17:53:10+00:00] File "https://raw.githubusercontent.com/scatterp2/webvm/main/examples/python3/pi_impl.py", line 968, in main [2026-11-08T17:53:10+00:00] File "https://raw.githubusercontent.com/scatterp2/webvm/main/examples/python3/pi_impl.py", line 927, in run_io_loop_proof [2026-11-08T17:53:10+00:00] USERNAME + "/webvm-tcp-link"), flush=True) [2026-11-08T17:53:10+00:00] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:10+00:00] File "/usr/lib/python3.11/urllib/request.py", line 216, in urlopen [2026-11-08T17:53:10+00:00] return opener.open(url, data, timeout) [2026-11-08T17:53:10+00:00] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/urllib/request.py", line 519, in open [2026-11-08T17:53:11+00:00] response = self._open(req, data) [2026-11-08T17:53:11+00:00] ^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/urllib/request.py", line 536, in _open [2026-11-08T17:53:11+00:00] result = self._call_chain(self.handle_open, protocol, protocol + [2026-11-08T17:53:11+00:00] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/urllib/request.py", line 496, in _call_chain [2026-11-08T17:53:11+00:00] result = func(*args) [2026-11-08T17:53:11+00:00] ^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/urllib/request.py", line 1404, in https_open [2026-11-08T17:53:11+00:00] return self.do_open(http.client.HTTPSConnection, req, [2026-11-08T17:53:11+00:00] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/urllib/request.py", line 1361, in do_open [2026-11-08T17:53:11+00:00] h.request(req.get_method(), req.selector, req.data, headers, [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/http/client.py", line 1311, in request [2026-11-08T17:53:11+00:00] self._send_request(method, url, body, headers, encode_chunked) [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/http/client.py", line 1357, in _send_request [2026-11-08T17:53:11+00:00] self.endheaders(body, encode_chunked=encode_chunked) [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/http/client.py", line 1306, in endheaders [2026-11-08T17:53:11+00:00] self._send_output(message_body, encode_chunked=encode_chunked) [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/http/client.py", line 1066, in _send_output [2026-11-08T17:53:11+00:00] self.send(msg) [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/http/client.py", line 1004, in send [2026-11-08T17:53:11+00:00] self.connect() [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/http/client.py", line 1483, in connect [2026-11-08T17:53:11+00:00] self.sock = self._context.wrap_socket(self.sock, [2026-11-08T17:53:11+00:00] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/ssl.py", line 517, in wrap_socket [2026-11-08T17:53:11+00:00] return self.sslsocket_class._create( [2026-11-08T17:53:11+00:00] ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/ssl.py", line 1121, in _create [2026-11-08T17:53:11+00:00] self.do_handshake() [2026-11-08T17:53:11+00:00] File "/usr/lib/python3.11/ssl.py", line 1394, in do_handshake [2026-11-08T17:53:11+00:00] self.settimeout(timeout) [2026-11-08T17:53:11+00:00] OverflowError: timestamp too large to convert to C _PyTime_t [2026-11-08T17:53:11+00:00] PI_WRAPPER_FINISHED returncode=1