WVMQWENWS_6D91C42F
source=WEBVM
time=2026-11-07T20:16:36+00:00
stage=PI_WRAPPER_FINISHED
[2026-11-07T20:11:56+00:00] PI_WRAPPER_STARTED tag=WVMQWENWS_6D91C42F script=pi.py
[2026-11-07T20:12:08+00:00] PI_IMPL_FETCHED source=main characters=34813
[2026-11-07T20:12:09+00:00] booting.
[2026-11-07T20:12:09+00:00] booting..
[2026-11-07T20:12:10+00:00] IO_LOOP_SOURCE_FETCHED file=controller.py attempt=1/10 characters=24317
[2026-11-07T20:12:12+00:00] IO_LOOP_SOURCE_FETCHED file=agent.py attempt=1/10 characters=10376
[2026-11-07T20:12:12+00:00] IO_LOOP_CONTROLLER_START dataset_id=simonday/webvm-io-loop-rx kernel_id=simonday/webvm-io-loop-proof
[2026-11-07T20:12:15+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-07T20:12:15.109+00:00", "timeout_seconds": 900}
[2026-11-07T20:12:15+00:00] IO_LOOP_CONTROLLER {"checksum": "4f22cb9b88790d5bd6793e8c0d4bad90c6bd55bb2b1f8cbb801ae0f6ab25d2aa", "event": "POC_FILES_WRITTEN", "notebook_bytes": 19307, "payload": "WEBVM_IO_LOOP_HELLO_V1", "request_id": "io-loop-proof-20261107T201215119609Z", "rx_bytes": 255, "sequence": 1, "time": "2026-11-07T20:12:15.640+00:00"}
[2026-11-07T20:13:15+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "status", "simonday/webvm-io-loop-rx"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-07T20:12:15.643+00:00", "timeout_seconds": 60}
[2026-11-07T20:13:19+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "status", "simonday/webvm-io-loop-rx"], "duration_ms": 59325.775, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "ready", "time": "2026-11-07T20:13:14.971+00:00"}
[2026-11-07T20:13:50+00:00] IO_LOOP_CONTROLLER {"dataset_id": "simonday/webvm-io-loop-rx", "event": "RX_DATASET_EXISTENCE_PROBE", "exists": true, "time": "2026-11-07T20:13:14.978+00:00"}
[2026-11-07T20:13:50+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "version", "-p", "/home/user/kaggle-io-loop-run/dataset", "-m", "WebVM IO loop RX message sequence 1", "-r", "skip"], "event": "API_REQUEST_START", "proxy_vars_removed": false, "time": "2026-11-07T20:13:14.985+00:00", "timeout_seconds": 300}
[2026-11-07T20:13:50+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "datasets", "version", "-p", "/home/user/kaggle-io-loop-run/dataset", "-m", "WebVM IO loop RX message sequence 1", "-r", "skip"], "duration_ms": 35710.655, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Starting upload for file rx_message.json\n\n  0%|          | 0.00/255 [00:00<?, ?B/s]\n100%|██████████| 255/255 [00:01<00:00, 141B/s]\n100%|██████████| 255/255 [00:02<00:00, 97.0B/s]\nUpload successful: rx_message.json (255B)\nDataset version is being created. Please check progress at https://www.kaggle.com/datasets/simonday/webvm-io-loop-rx\n", "time": "2026-11-07T20:13:50.696+00:00"}
[2026-11-07T20:14:22+00:00] IO_LOOP_CONTROLLER {"dataset_id": "simonday/webvm-io-loop-rx", "event": "RX_RESOURCE_PUBLISHED", "message_checksum": "4f22cb9b88790d5bd6793e8c0d4bad90c6bd55bb2b1f8cbb801ae0f6ab25d2aa", "time": "2026-11-07T20:13:50.716+00:00"}
[2026-11-07T20:14:27+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-07T20:13:50.728+00:00", "timeout_seconds": 90}
[2026-11-07T20:14:27+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": 31609.066, "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/255 [00:00<?, ?B/s]\n100%|██████████| 255/255 [00:00<00:00, 3.67kB/s]\n\n", "time": "2026-11-07T20:14:22.337+00:00"}
[2026-11-07T20:14:51+00:00] IO_LOOP_CONTROLLER {"checksum": "4f22cb9b88790d5bd6793e8c0d4bad90c6bd55bb2b1f8cbb801ae0f6ab25d2aa", "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-20261107T201215119609Z", "time": "2026-11-07T20:14:22.355+00:00"}
[2026-11-07T20:14:51+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-07T20:14:22.361+00:00", "timeout_seconds": 300}
[2026-11-07T20:14:51+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "push", "-p", "/home/user/kaggle-io-loop-run/kernel"], "duration_ms": 29321.055, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "Kernel version 13 successfully pushed.  Please check progress at https://www.kaggle.com/code/simonday/webvm-io-loop-proof\n", "time": "2026-11-07T20:14:51.684+00:00"}
[2026-11-07T20:15:17+00:00] IO_LOOP_CONTROLLER {"event": "KERNEL_SUBMITTED", "kernel_id": "simonday/webvm-io-loop-proof", "time": "2026-11-07T20:14:51.716+00:00"}
[2026-11-07T20:15:17+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-07T20:14:51.736+00:00", "timeout_seconds": 60}
[2026-11-07T20:15:17+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "duration_ms": 25608.71, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.RUNNING\"\n", "time": "2026-11-07T20:15:17.345+00:00"}
[2026-11-07T20:15:27+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-07T20:15:17.350+00:00"}
[2026-11-07T20:15:31+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-07T20:15:27.436+00:00", "timeout_seconds": 60}
[2026-11-07T20:15:54+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "duration_ms": 27029.32, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.RUNNING\"\n", "time": "2026-11-07T20:15:54.472+00:00"}
[2026-11-07T20:16:04+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-07T20:15:54.496+00:00"}
[2026-11-07T20:16:04+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-07T20:16:04.521+00:00", "timeout_seconds": 60}
[2026-11-07T20:16:28+00:00] IO_LOOP_CONTROLLER {"attempt": "configured_environment", "command": ["kaggle", "kernels", "status", "simonday/webvm-io-loop-proof"], "duration_ms": 23778.31, "event": "API_REQUEST_RESULT", "exit_code": 0, "output_tail": "simonday/webvm-io-loop-proof has status \"KernelWorkerStatus.COMPLETE\"\n", "time": "2026-11-07T20:16:28.299+00:00"}
[2026-11-07T20:16:28+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-07T20:16:28.323+00:00"}
[2026-11-07T20:16:28+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-07T20:16:28.537+00:00", "timeout_seconds": 300}
[2026-11-07T20:16:32+00:00] Traceback (most recent call last):
[2026-11-07T20:16:36+00:00]   File "/home/user/examples/python3/pi.py", line 65, in <module>
[2026-11-07T20:16:36+00:00]     main()
[2026-11-07T20:16:36+00:00]   File "https://raw.githubusercontent.com/scatterp2/webvm/main/examples/python3/pi_impl.py", line 872, in main
[2026-11-07T20:16:36+00:00]   File "https://raw.githubusercontent.com/scatterp2/webvm/main/examples/python3/pi_impl.py", line 845, in run_io_loop_proof
[2026-11-07T20:16:36+00:00]   File "/usr/lib/python3.11/selectors.py", line 468, in select
[2026-11-07T20:16:36+00:00]     fd_event_list = self._selector.poll(timeout, max_ev)
[2026-11-07T20:16:36+00:00]                     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[2026-11-07T20:16:36+00:00] OverflowError: timestamp too large to convert to C _PyTime_t
[2026-11-07T20:16:36+00:00] PI_WRAPPER_FINISHED returncode=1