[17:17:21.398] New invocation is queued and will start shortly
[17:17:23.396] Starting the invocation (attempt 1)
[17:17:23.422] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2777f7ce618fb5e04c1e468c5bc7ff6054c862e7"
[17:17:23.422] Popped gitiles commit info from properties and tags
[17:17:23.422] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:17:23.423] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:17:23.423] Buildbucket request:
{
"requestId": "8899150826249133664",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux MSan"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2777f7ce618fb5e04c1e468c5bc7ff6054c862e7",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8899150826249133664"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Linux MSan"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:17:24.058] Scheduled build:
{
"id": "8733720763419894689",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux MSan"
},
"number": 198385,
"createdBy": "project:chromium",
"createTime": "2024-10-18T17:17:23.470804291Z",
"updateTime": "2024-10-18T17:17:23.470804291Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2777f7ce618fb5e04c1e468c5bc7ff6054c862e7",
"ref": "refs/heads/main"
}
}
}
[17:17:24.058] Task URL: https://cr-buildbucket.appspot.com/build/8733720763419894689
[17:17:24.058] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:2:0) after 7m55s
[17:17:24.916] Received PubSub notification, asking Buildbucket for the build status
[17:17:24.932] Build status: SCHEDULED
[17:17:31.574] Received PubSub notification, asking Buildbucket for the build status
[17:17:31.602] Build status: STARTED
[17:25:19.131] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:2:0)
[17:25:19.155] Build status: STARTED
[17:25:19.155] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:5:0) after 8m23s
[17:33:42.196] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:5:0)
[17:33:42.235] Build status: STARTED
[17:33:42.235] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:6:0) after 2m7s
[17:35:49.258] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:6:0)
[17:35:49.286] Build status: STARTED
[17:35:49.286] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:7:0) after 4m52s
[17:40:41.355] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:7:0)
[17:40:41.378] Build status: STARTED
[17:40:41.378] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:8:0) after 6m55s
[17:47:36.443] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:8:0)
[17:47:36.459] Build status: STARTED
[17:47:36.459] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:9:0) after 8m26s
[17:56:02.499] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:9:0)
[17:56:02.525] Build status: STARTED
[17:56:02.525] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:10:0) after 9m13s
[18:05:15.609] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:10:0)
[18:05:15.644] Build status: STARTED
[18:05:15.645] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:11:0) after 4m48s
[18:10:03.694] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:11:0)
[18:10:03.713] Build status: STARTED
[18:10:03.713] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:12:0) after 9m29s
[18:19:32.789] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:12:0)
[18:19:32.944] Build status: STARTED
[18:19:32.944] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:13:0) after 1m36s
[18:21:08.961] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:13:0)
[18:21:08.984] Build status: STARTED
[18:21:08.984] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:14:0) after 7m57s
[18:29:06.001] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:14:0)
[18:29:06.050] Build status: STARTED
[18:29:06.050] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:15:0) after 9m19s
[18:38:25.071] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:15:0)
[18:38:25.097] Build status: STARTED
[18:38:25.097] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:16:0) after 7m28s
[18:45:53.118] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:16:0)
[18:45:53.136] Build status: STARTED
[18:45:53.136] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:17:0) after 9m5s
[18:54:58.142] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:17:0)
[18:54:58.186] Build status: STARTED
[18:54:58.186] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:18:0) after 4m31s
[18:59:29.211] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:18:0)
[18:59:29.228] Build status: STARTED
[18:59:29.228] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:19:0) after 4m55s
[19:04:24.303] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:19:0)
[19:04:24.321] Build status: STARTED
[19:04:24.321] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:20:0) after 7m19s
[19:11:43.393] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:20:0)
[19:11:43.428] Build status: STARTED
[19:11:43.428] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:21:0) after 4m12s
[19:15:55.504] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:21:0)
[19:15:55.521] Build status: STARTED
[19:15:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:22:0) after 7m25s
[19:23:20.780] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:22:0)
[19:23:20.869] Build status: STARTED
[19:23:20.869] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:23:0) after 3m16s
[19:26:37.019] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:23:0)
[19:26:37.056] Build status: STARTED
[19:26:37.057] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:24:0) after 5m58s
[19:32:35.334] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:24:0)
[19:32:35.704] Build status: STARTED
[19:32:35.704] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:25:0) after 9m47s
[19:42:22.720] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:25:0)
[19:42:22.740] Build status: STARTED
[19:42:22.740] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:26:0) after 8m29s
[19:50:51.956] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:26:0)
[19:50:51.971] Build status: STARTED
[19:50:51.971] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:27:0) after 1m31s
[19:52:22.989] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:27:0)
[19:52:23.007] Build status: STARTED
[19:52:23.007] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:28:0) after 4m38s
[19:57:01.055] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:28:0)
[19:57:01.078] Build status: STARTED
[19:57:01.078] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:29:0) after 2m22s
[19:59:23.097] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:29:0)
[19:59:23.114] Build status: STARTED
[19:59:23.114] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:30:0) after 5m1s
[20:04:24.133] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:30:0)
[20:04:24.174] Build status: STARTED
[20:04:24.174] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:31:0) after 4m3s
[20:08:27.343] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:31:0)
[20:08:27.359] Build status: STARTED
[20:08:27.359] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:32:0) after 8m12s
[20:16:39.432] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:32:0)
[20:16:39.450] Build status: STARTED
[20:16:39.450] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:33:0) after 1m33s
[20:18:12.480] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:33:0)
[20:18:12.499] Build status: STARTED
[20:18:12.499] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux MSan:8899150826249133664:34:0) after 2m9s
[20:19:58.675] Received PubSub notification, asking Buildbucket for the build status
[20:19:58.693] Build:
{
"id": "8733720763419894689",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux MSan"
},
"number": 198385,
"createdBy": "project:chromium",
"createTime": "2024-10-18T17:17:23.470804291Z",
"startTime": "2024-10-18T17:17:31.391612287Z",
"endTime": "2024-10-18T20:19:58.381215935Z",
"updateTime": "2024-10-18T20:19:58.381215935Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "2777f7ce618fb5e04c1e468c5bc7ff6054c862e7",
"ref": "refs/heads/main"
}
}
}
[20:19:58.693] Invocation finished in 3h2m37.30487401s with status FAILED