WVMQWENWS_6D91C42F
source=WEBVM
time=2026-11-08T05:54:30+00:00
stage=PI_HEARTBEAT
[2026-11-08T05:52:54+00:00] PI_WRAPPER_STARTED tag=WVMQWENWS_6D91C42F script=pi.py
[2026-11-08T05:53:05+00:00] PI_IMPL_FETCHED source=main characters=35466
[2026-11-08T05:53:05+00:00] booting.
[2026-11-08T05:53:06+00:00] booting..
[2026-11-08T05:53:07+00:00] IO_LOOP_SOURCE_FETCHED file=controller.py attempt=1/10 characters=31431
[2026-11-08T05:53:08+00:00] IO_LOOP_SOURCE_FETCHED file=agent.py attempt=1/10 characters=10376
[2026-11-08T05:53:10+00:00] IO_LOOP_SOURCE_FETCHED file=tcp_socks5.py attempt=1/10 characters=19593
[2026-11-08T05:53:10+00:00] RX_TX_PROOF_SKIPPED already_validated=1 override=WEBVM_RUN_RX_TX_PROOF=1
[2026-11-08T05:53:10+00:00] TCP_LINK_CONTROLLER_START kernel_id=simonday/webvm-tcp-link
[2026-11-08T05:53:13+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-08T05:53:12.893+00:00", "timeout_seconds": 900}
[2026-11-08T05:53:13+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-08T05:53:12.903+00:00", "timeout_seconds": 20}
[2026-11-08T05:53:34+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 21271.34, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T05:53:34.183+00:00"}
[2026-11-08T05:53: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-08T05:53:34.189+00:00", "timeout_seconds": 20}
[2026-11-08T05:53:55+00:00] IO_LOOP_CONTROLLER {"attempt": "proxy_bypass", "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "duration_ms": 20988.615, "event": "API_REQUEST_TIMEOUT", "output_tail": "", "time": "2026-11-08T05:53:55.178+00:00"}
[2026-11-08T05:53:55+00:00] IO_LOOP_CONTROLLER {"attempts": 2, "command": ["kaggle", "kernels", "status", "simonday/webvm-tcp-link"], "elapsed_ms": 42285.335, "event": "API_REQUEST_EXHAUSTED", "read_only": true, "reason": "all permitted attempts timed out", "time": "2026-11-08T05:53:55.185+00:00"}
[2026-11-08T05:53:55+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-08T05:53:55.187+00:00"}
[2026-11-08T05:53:56+00:00] IO_LOOP_CONTROLLER {"event": "POC_FILES_WRITTEN", "notebook_bytes": 33344, "service": "tailscale-serve-tcp-to-http-connect-socks5", "time": "2026-11-08T05:53:55.972+00:00"}
[2026-11-08T05:53:56+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-08T05:53:55.976+00:00", "timeout_seconds": 300}
[2026-11-08T05:54:30+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-tcp-link-run/kernel"], "duration_ms": 33865.73, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel version 3 successfully pushed.  Please check progress at https://www.kaggle.com/code/simonday/webvm-tcp-link\n", "time": "2026-11-08T05:54:29.842+00:00"}