WVMQWENWS_6D91C42F
source=WEBVM
time=2026-11-11T08:33:11+00:00
stage=PI_HEARTBEAT
[2026-11-11T08:19:03+00:00] PI_WRAPPER_STARTED tag=WVMQWENWS_6D91C42F script=pi.py
[2026-11-11T08:19:15+00:00] PI_IMPL_FETCHED source=main characters=59266
[2026-11-11T08:19:16+00:00] booting.
[2026-11-11T08:19:16+00:00] booting..
[2026-11-11T08:19:16+00:00] GPU_DIAGNOSTIC_DEFERRED reason=prioritize_RX_TX_and_live_TCP_proof
[2026-11-11T08:19:18+00:00] IO_LOOP_SOURCE_FETCHED file=controller.py attempt=1/10 characters=58931
[2026-11-11T08:19:19+00:00] IO_LOOP_SOURCE_FETCHED file=agent.py attempt=1/10 characters=21992
[2026-11-11T08:19:20+00:00] TCP_LINK_MARKER_HANDLER_PATCHED source=tcp_socks5.py mode=runtime-injection
[2026-11-11T08:19:21+00:00] IO_LOOP_SOURCE_FETCHED file=tcp_socks5.py attempt=1/10 characters=21980
[2026-11-11T08:19:22+00:00] IO_LOOP_SOURCE_FETCHED file=remote_probe.py attempt=1/10 characters=2493
[2026-11-11T08:19:23+00:00] IO_LOOP_SOURCE_FETCHED file=terminal_service.py attempt=1/10 characters=6373
[2026-11-11T08:19:24+00:00] IO_LOOP_SOURCE_FETCHED file=remote_shell.py attempt=1/10 characters=3115
[2026-11-11T08:19:24+00:00] IO_LOOP_CONTROLLER_START dataset_id=simonday/webvm-io-loop-rx kernel_id=simonday/webvm-io-loop-proof
[2026-11-11T08:19:26+00:00] RX_TX_INITIAL_PROOF_BACKGROUND_STARTED command_channel=available
[2026-11-11T08:19:26+00:00] RX_TX_TERMINAL_LISTENING host=127.0.0.1 port=2323 transport=Kaggle-RX-TX
[2026-11-11T08:19:26+00:00] WEBVM_TERMINAL_SERVER_DIAGNOSTIC_FAIL error=OSError: [Errno 22] Invalid argument
[2026-11-11T08:19:26+00:00] WEBVM_TERMINAL_SELFTEST_SKIPPED reason=loopback_socket_test_not_required
[2026-11-11T08:19:26+00:00] RX_TX_TOKENIZED_PROXY_MARKER_TEST_SCHEDULED_AFTER_ROUTE_DISCOVERY no_tailscale=true
[2026-11-11T08:19:26+00:00] RX_TX_REMOTE_COMMAND_POLL_STARTED interval_seconds=30 current_sha256=dd24e68864ed4a5cb3a220b702380b97a0bfa24737d6228fe5f70322e97048f8
[2026-11-11T08:19:28+00:00] IO_LOOP_CONTROLLER {"dataset_id": "simonday/webvm-io-loop-rx", "event": "RUN_BEGIN", "kernel_id": "simonday/webvm-io-loop-proof", "poll_seconds": 10, "time": "2026-11-11T08:19:28.703+00:00", "timeout_seconds": 900}
[2026-11-11T08:19:28+00:00] IO_LOOP_CONTROLLER {"encoded_bytes": 3324, "event": "PYTHON_PAYLOAD_ENCODED", "path": "/home/user/kaggle-io-loop/remote_probe.py", "sha256": "dd24e68864ed4a5cb3a220b702380b97a0bfa24737d6228fe5f70322e97048f8", "source_bytes": 2493, "time": "2026-11-11T08:19:28.823+00:00"}
[2026-11-11T08:19:29+00:00] IO_LOOP_CONTROLLER {"checksum": "43d99baf9db63d85689ba6fbfde994c035af0ad9299cc9ddfc856317811fdbb0", "event": "POC_FILES_WRITTEN", "notebook_bytes": 34779, "payload": "IyEvdXNyL2Jpbi9lbnYgcHl0aG9uMwoiIiJGaW5kIHRoZSBLYWdnbGUgcHJveHkgdG9rZW4gdXNpbmcgdGhlIG5vdGVib29rJ3MgZnVsbCBwcm9jZXNzIGxpc3RpbmcuCgpUaGUgbGl2ZSBwcm9jZXNzIHRhYmxlIGlzIHNlYXJjaGVkIHdpdGggYHBzIGF1eHd3YCwgYXMgcmVxdWVzdGVkLiBUaGUKbWF0Y2hpbmcgdG9rZW4gaXMgd3JpdHRlbiBvbmx5IHRvIC9rYWdnbGUvd29ya2luZy93ZWJ2bV9wcm94eV9yb3V0ZS5qc29uCmZvciByZXR1cm4gdGhyb3VnaCB0aGUgZXhpc3RpbmcgUlgvVFggY2hhbm5lbC4gSXQgaXMgbmV2ZXIgcHJpbnRlZC4KIiIiCmltcG9ydCBqc29uCmltcG9ydCByZQppbXBvcnQgc3VicHJvY2Vzcwpmcm9tIHBhdGhsaWIgaW1wb3J0IFBhdGgKCkhPU1QgPSAia2tiLXByb2R1Y3Rpb24uanVweXRlci1wcm94eS5rYWdnbGUubmV0IgpSRVNVTFQgPSBQYXRoKCIva2FnZ2xlL3dvcmtpbmcvd2Vidm1fcHJveHlfcm91dGUuanNvbiIpClJPVVRFX1JFID0gcmUuY29tcGlsZShyIi9rLyhbMC05XSspLyhbXi9ccydcIj9dKykvcHJveHkoPzovfCQpIikKCnRyeToKICAgIHBzID0gc3VicHJvY2Vzcy5ydW4oCiAgICAgICAgWyJwcyIsICJhdXh3dyJdLAogICAgICAgIGNoZWNrPVRydWUsCiAgICAgICAgY2FwdHVyZV9vdXRwdXQ9VHJ1ZSwKICAgICAgICB0ZXh0PVRydWUsCiAgICAgICAgdGltZW91dD0xMCwKICAgICkKICAgIHByb2Nlc3NfbGluZXMgPSBwcy5zdGRvdXQuc3BsaXRsaW5lcygpCmV4Y2VwdCAoT1NFcnJvciwgc3VicHJvY2Vzcy5TdWJwcm9jZXNzRXJyb3IpIGFzIGV4YzoKICAgIHRyeToKICAgICAgICBSRVNVTFQudW5saW5rKCkKICAgIGV4Y2VwdCBGaWxlTm90Rm91bmRFcnJvcjoKICAgICAgICBwYXNzCiAgICBwcmludCgKICAgICAgICAiV0VCVk1fUFJPWFlfUk9VVEVfRElTQ09WRVJZIGZvdW5kPWZhbHNlIG1ldGhvZD1wc19hdXh3dyAiCiAgICAgICAgImVycm9yX3R5cGU9e30iLmZvcm1hdCh0eXBlKGV4YykuX19uYW1lX18pLAogICAgICAgIGZsdXNoPVRydWUsCiAgICApCiAgICByYWlzZSBTeXN0ZW1FeGl0KDApCgpqdXB5dGVyX2xpbmVzID0gWwogICAgbGluZSBmb3IgbGluZSBpbiBwcm9jZXNzX2xpbmVzCiAgICBpZiAianVweXRlciIgaW4gbGluZS5sb3dlcigpIG9yICJub3RlYm9vayIgaW4gbGluZS5sb3dlcigpCl0Kc2VhcmNoX2dyb3VwcyA9IChqdXB5dGVyX2xpbmVzLCBwcm9jZXNzX2xpbmVzKQpmb3VuZCA9IE5vbmUKc291cmNlX2dyb3VwID0gTm9uZQoKIyBTZWFyY2ggdGhlIGVudGlyZSBwcyBjb21tYW5kIGxpbmUsIHByaW9yaXRpc2luZyBKdXB5dGVyL05vdGVib29rIHByb2Nlc3Nlcy4KZm9yIGdyb3VwX25hbWUsIGxpbmVzIGluICgoImp1cHl0ZXJfcHJvY2VzcyIsIGp1cHl0ZXJfbGluZXMpLCAoImFsbF9wcm9jZXNzZXMiLCBwcm9jZXNzX2xpbmVzKSk6CiAgICBmb3IgbGluZSBpbiBsaW5lczoKICAgICAgICBtYXRjaCA9IFJPVVRFX1JFLnNlYXJjaChsaW5lKQogICAgICAgIGlmIG1hdGNoOgogICAgICAgICAgICBmb3VuZCA9IHsKICAgICAgICAgICAgICAgICJob3N0IjogSE9TVCwKICAgICAgICAgICAgICAgICJwYXRoIjogIi9rL3t9L3t9L3Byb3h5Ii5mb3JtYXQobWF0Y2guZ3JvdXAoMSksIG1hdGNoLmdyb3VwKDIpKSwKICAgICAgICAgICAgICAgICJrZXJuZWxfaWQiOiBtYXRjaC5ncm91cCgxKSwKICAgICAgICAgICAgICAgICJ0b2tlbiI6IG1hdGNoLmdyb3VwKDIpLAogICAgICAgICAgICB9CiAgICAgICAgICAgIHNvdXJjZV9ncm91cCA9IGdyb3VwX25hbWUKICAgICAgICAgICAgYnJlYWsKICAgIGlmIGZvdW5kOgogICAgICAgIGJyZWFrCgppZiBub3QgZm91bmQ6CiAgICB0cnk6CiAgICAgICAgUkVTVUxULnVubGluaygpCiAgICBleGNlcHQgRmlsZU5vdEZvdW5kRXJyb3I6CiAgICAgICAgcGFzcwogICAgcHJpbnQoCiAgICAgICAgIldFQlZNX1BST1hZX1JPVVRFX0RJU0NPVkVSWSBmb3VuZD1mYWxzZSBtZXRob2Q9cHNfYXV4d3cgIgogICAgICAgICJwcm9jZXNzX2NvdW50PXt9IGp1cHl0ZXJfcHJvY2Vzc19jb3VudD17fSIuZm9ybWF0KAogICAgICAgICAgICBtYXgoMCwgbGVuKHByb2Nlc3NfbGluZXMpIC0gMSksIGxlbihqdXB5dGVyX2xpbmVzKSksCiAgICAgICAgZmx1c2g9VHJ1ZSwKICAgICkKZWxzZToKICAgIFJFU1VMVC5wYXJlbnQubWtkaXIocGFyZW50cz1UcnVlLCBleGlzdF9vaz1UcnVlKQogICAgUkVTVUxULndyaXRlX3RleHQoanNvbi5kdW1wcyhmb3VuZCwgc29ydF9rZXlzPVRydWUpICsgIlxuIiwgZW5jb2Rpbmc9InV0Zi04IikKICAgIHByaW50KAogICAgICAgICJXRUJWTV9QUk9YWV9ST1VURV9ESVNDT1ZFUlkgZm91bmQ9dHJ1ZSBtZXRob2Q9cHNfYXV4d3cgIgogICAgICAgICJzb3VyY2U9e30ga2VybmVsX2lkPXt9IHRva2VuX3ByZXNlbnQ9dHJ1ZSIuZm9ybWF0KAogICAgICAgICAgICBzb3VyY2VfZ3JvdXAsIGZvdW5kWyJrZXJuZWxfaWQiXSksCiAgICAgICAgZmx1c2g9VHJ1ZSwKICAgICkK", "request_id": "io-loop-proof-20261111T081928815019Z", "rx_bytes": 3565, "sequence": 1, "time": "2026-11-11T08:19:29.386+00:00"}
[2026-11-11T08:19:30+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "version", "-p", "/home/user/kaggle-io-loop-run/dataset", "-m", "WebVM RX io-loop-proof-20261111T081928815019Z", "-r", "skip"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-11T08:19:29.398+00:00", "timeout_seconds": 300}
[2026-11-11T08:20:37+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "version", "-p", "/home/user/kaggle-io-loop-run/dataset", "-m", "WebVM RX io-loop-proof-20261111T081928815019Z", "-r", "skip"], "duration_ms": 67512.325, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Starting upload for file rx_message.json\n\n  0%|          | 0.00/3.48k [00:00<?, ?B/s]\n100%|██████████| 3.48k/3.48k [00:01<00:00, 2.97kB/s]\n100%|██████████| 3.48k/3.48k [00:01<00:00, 1.87kB/s]\nUpload successful: rx_message.json (3KB)\nDataset version is being created. Please check progress at https://www.kaggle.com/datasets/simonday/webvm-io-loop-rx\n", "time": "2026-11-11T08:20:36.913+00:00"}
[2026-11-11T08:20:43+00:00] IO_LOOP_CONTROLLER {"dataset_id": "simonday/webvm-io-loop-rx", "event": "RX_RESOURCE_PUBLISHED", "message_checksum": "43d99baf9db63d85689ba6fbfde994c035af0ad9299cc9ddfc856317811fdbb0", "time": "2026-11-11T08:20:36.973+00:00"}
[2026-11-11T08:20:43+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "download", "simonday/webvm-io-loop-rx", "-f", "rx_message.json", "-p", "/home/user/kaggle-io-loop-run/output/published_rx_verify", "--unzip", "-o"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-11T08:20:37.137+00:00", "timeout_seconds": 90}
[2026-11-11T08:21:07+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "download", "simonday/webvm-io-loop-rx", "-f", "rx_message.json", "-p", "/home/user/kaggle-io-loop-run/output/published_rx_verify", "--unzip", "-o"], "duration_ms": 30425.73, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Dataset URL: https://www.kaggle.com/datasets/simonday/webvm-io-loop-rx\nLicense(s): CC0-1.0\nDownloading rx_message.json to /home/user/kaggle-io-loop-run/output/published_rx_verify\n\n  0%|          | 0.00/3.48k [00:00<?, ?B/s]\n100%|██████████| 3.48k/3.48k [00:00<00:00, 53.2kB/s]\n\n", "time": "2026-11-11T08:21:07.564+00:00"}
[2026-11-11T08:21:10+00:00] IO_LOOP_CONTROLLER {"checksum": "43d99baf9db63d85689ba6fbfde994c035af0ad9299cc9ddfc856317811fdbb0", "dataset_id": "simonday/webvm-io-loop-rx", "event": "RX_PUBLICATION_VERIFIED", "file": "/home/user/kaggle-io-loop-run/output/published_rx_verify/rx_message.json", "request_id": "io-loop-proof-20261111T081928815019Z", "time": "2026-11-11T08:21:07.581+00:00"}
[2026-11-11T08:21:10+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-io-loop-run/kernel"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-11T08:21:07.588+00:00", "timeout_seconds": 300}
[2026-11-11T08:21:34+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-io-loop-run/kernel"], "duration_ms": 26682.925, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel version 42 successfully pushed.  Please check progress at https://www.kaggle.com/code/simonday/webvm-io-loop-proof\n", "time": "2026-11-11T08:21:34.272+00:00"}
[2026-11-11T08:21:36+00:00] IO_LOOP_CONTROLLER {"event": "KERNEL_SUBMITTED", "kernel_id": "simonday/webvm-io-loop-proof", "time": "2026-11-11T08:21:34.367+00:00"}