[Bug]: Inconsistent start times when mounting to a local directory

[avi12]

Is there an existing issue for the same bug?

• I have checked the existing issues.

Describe the bug and reproduction steps

1. docker run -it --rm --pull=always `
    -e SANDBOX_RUNTIME_CONTAINER_IMAGE=docker.all-hands.dev/all-hands-ai/runtime:main-nikolaik `
    -e WORKSPACE_MOUNT_PATH="C:\repositories\extensions\youtube-time-manager" `
    -e LOG_ALL_EVENTS=true `
    -v /var/run/docker.sock:/var/run/docker.sock `
    -v C:/repositories/extensions/youtube-time-manager:/opt/workspace_base `
    -p 3000:3000 `
    --add-host host.docker.internal:host-gateway `
    --name openhands-app `
    docker.all-hands.dev/all-hands-ai/openhands:main

2. Start 127.0.0.1:3000
3. Make sure that the LLM is set up, in my case Claude 3.5 Sonnet
4. Send a text prompt
5. Initially it will say "waiting for client to become ready"
6. The time for it to start up and start sending the input via the API can equally to be 5 minutes or 50 minutes

OpenHands Installation

Docker command in README

OpenHands Version

main

Operating System

Windows 10, PowerShell

Logs, Errors, Screenshots, and Additional Context

No response

[mamoodi]

Wow that's a massive difference 5 and 50 minutes.
When it takes a long time, are you able to determine what's happening based on the logs in the terminal?

[avi12]

Nope, when it's able to start it's pretty much at random for me

[avi12]

The agent randomly started a few minutes ago and that's the log I was able to capture

INFO:     172.17.0.1:35376 - "GET /api/options/config HTTP/1.1" 200 OK
2024-12-26T17:08:22.900717429Z INFO:     172.17.0.1:35362 - "GET /api/settings HTTP/1.1" 200 OK
2024-12-26T17:08:24.882951932Z INFO:     ('172.17.0.1', 35378) - "WebSocket /socket.io/?latest_event_id=0&conversation_id=4bddfa58c4af4ef4beabdadb6ca3bbb3&EIO=4&transport=websocket" [accepted]
2024-12-26T17:08:24.886529688Z 17:08:24 - openhands:INFO: listen_socket.py:27 - sio:connect: r_cw-UUmL_o4LYmlAAAL
2024-12-26T17:08:24.886555724Z 17:08:24 - openhands:INFO: manager.py:182 - join_conversation:4bddfa58c4af4ef4beabdadb6ca3bbb3:r_cw-UUmL_o4LYmlAAAL
2024-12-26T17:08:24.886877307Z 17:08:24 - openhands:INFO: manager.py:325 - _get_event_stream:4bddfa58c4af4ef4beabdadb6ca3bbb3
2024-12-26T17:08:24.886892640Z 17:08:24 - openhands:INFO: manager.py:308 - maybe_start_agent_loop:4bddfa58c4af4ef4beabdadb6ca3bbb3
2024-12-26T17:08:24.887091353Z 17:08:24 - openhands:INFO: manager.py:311 - start_agent_loop:4bddfa58c4af4ef4beabdadb6ca3bbb3
2024-12-26T17:08:24.895871453Z 17:08:24 - openhands:INFO: manager.py:325 - _get_event_stream:4bddfa58c4af4ef4beabdadb6ca3bbb3
2024-12-26T17:08:24.896089410Z 17:08:24 - openhands:INFO: manager.py:328 - found_local_agent_loop:4bddfa58c4af4ef4beabdadb6ca3bbb3
2024-12-26T17:08:25.991928813Z 17:08:25 - openhands:INFO: eventstream_runtime.py:194 - [runtime 4bddfa58c4af4ef4beabdadb6ca3bbb3] Waiting for client to become ready at http://host.docker.internal:37364...
2024-12-26T17:08:26.041769247Z 17:08:26 - openhands:INFO: eventstream_runtime.py:200 - [runtime 4bddfa58c4af4ef4beabdadb6ca3bbb3] Runtime is ready.
2024-12-26T17:08:26.170137175Z 17:08:26 - openhands:ERROR: base.py:231 - [runtime 4bddfa58c4af4ef4beabdadb6ca3bbb3] Failed to read openhands_instructions
2024-12-26T17:08:26.174867807Z 17:08:26 - openhands:INFO: base.py:239 - [runtime 4bddfa58c4af4ef4beabdadb6ca3bbb3] Found 0 custom microagents.
2024-12-26T17:08:26.177163808Z 17:08:26 - openhands:INFO: agent_controller.py:204 - [Agent Controller 4bddfa58c4af4ef4beabdadb6ca3bbb3] Starting step loop...
2024-12-26T17:08:26.180101377Z 17:08:26 - openhands:INFO: agent_controller.py:347 - [Agent Controller 4bddfa58c4af4ef4beabdadb6ca3bbb3] Setting agent(CodeActAgent) state from AgentState.LOADING to AgentState.INIT
2024-12-26T17:08:26.183444051Z 17:08:26 - OBSERVATION
2024-12-26T17:08:26.183461829Z [Agent Controller 4bddfa58c4af4ef4beabdadb6ca3bbb3] AgentStateChangedObservation(content='', agent_state=<AgentState.INIT: 'init'>, observation='agent_state_changed')
...

[avi12]

IDK what's happening anymore

vlc-record-2024-12-26-19h34m17s-2024-12-26.19-27-05.msedge.mp4-.mp4

this is the Docker image after it pulled from the main branch