[04:00:07.347] New invocation is queued and will start shortly
[04:00:08.893] Starting the invocation (attempt 1)
[04:00:08.923] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d4631ac72e5b6fac2dc454ff15a9d162b8c7fc4f"
[04:00:08.923] Popped gitiles commit info from properties and tags
[04:00:08.923] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:00:08.923] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:00:08.923] Buildbucket request:
{
"requestId": "8897479641524285488",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-fuzz-coverage"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4631ac72e5b6fac2dc454ff15a9d162b8c7fc4f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8897479641524285488"
},
{
"key": "scheduler_job_id",
"value": "chromium/linux-fuzz-coverage"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[04:00:09.689] Scheduled build:
{
"id": "8732049579137193857",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-fuzz-coverage"
},
"number": 753,
"createdBy": "project:chromium",
"createTime": "2024-11-06T04:00:08.998327973Z",
"updateTime": "2024-11-06T04:00:08.998327973Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4631ac72e5b6fac2dc454ff15a9d162b8c7fc4f",
"ref": "refs/heads/main"
}
}
}
[04:00:09.689] Task URL: https://cr-buildbucket.appspot.com/build/8732049579137193857
[04:00:09.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:2:0) after 9m31s
[04:00:12.258] Received PubSub notification, asking Buildbucket for the build status
[04:00:12.280] Build status: SCHEDULED
[04:09:40.663] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:2:0)
[04:09:40.693] Build status: SCHEDULED
[04:09:40.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:4:0) after 2m30s
[04:12:11.103] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:4:0)
[04:12:11.134] Build status: SCHEDULED
[04:12:11.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:5:0) after 8m12s
[04:20:23.405] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:5:0)
[04:20:23.428] Build status: SCHEDULED
[04:20:23.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:6:0) after 7m46s
[04:28:09.443] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:6:0)
[04:28:09.461] Build status: SCHEDULED
[04:28:09.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:7:0) after 4m53s
[04:33:02.750] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:7:0)
[04:33:02.781] Build status: SCHEDULED
[04:33:02.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:8:0) after 3m42s
[04:36:44.846] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:8:0)
[04:36:44.902] Build status: SCHEDULED
[04:36:44.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:9:0) after 3m28s
[04:40:12.930] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:9:0)
[04:40:12.948] Build status: SCHEDULED
[04:40:12.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:10:0) after 4m0s
[04:44:13.110] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:10:0)
[04:44:13.130] Build status: SCHEDULED
[04:44:13.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:11:0) after 9m48s
[04:46:24.772] Received PubSub notification, asking Buildbucket for the build status
[04:46:24.798] Build status: STARTED
[04:54:01.250] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:11:0)
[04:54:01.335] Build status: STARTED
[04:54:01.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:13:0) after 1m17s
[04:55:18.396] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:13:0)
[04:55:18.450] Build status: STARTED
[04:55:18.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:14:0) after 2m0s
[04:57:18.534] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:14:0)
[04:57:18.574] Build status: STARTED
[04:57:18.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:15:0) after 8m17s
[05:05:36.003] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:15:0)
[05:05:36.022] Build status: STARTED
[05:05:36.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:16:0) after 4m24s
[05:10:00.037] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:16:0)
[05:10:00.109] Build status: STARTED
[05:10:00.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:17:0) after 4m14s
[05:14:14.300] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:17:0)
[05:14:14.318] Build status: STARTED
[05:14:14.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:18:0) after 2m18s
[05:16:32.403] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:18:0)
[05:16:32.421] Build status: STARTED
[05:16:32.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:19:0) after 6m36s
[05:23:08.584] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:19:0)
[05:23:08.603] Build status: STARTED
[05:23:08.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:20:0) after 3m10s
[05:26:18.722] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:20:0)
[05:26:18.779] Build status: STARTED
[05:26:18.779] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:21:0) after 6m46s
[05:33:05.345] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:21:0)
[05:33:05.366] Build status: STARTED
[05:33:05.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:22:0) after 1m6s
[05:34:11.589] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:22:0)
[05:34:11.608] Build status: STARTED
[05:34:11.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:23:0) after 9m48s
[05:43:59.674] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:23:0)
[05:43:59.696] Build status: STARTED
[05:43:59.696] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:24:0) after 3m57s
[05:47:56.718] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:24:0)
[05:47:56.739] Build status: STARTED
[05:47:56.739] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:25:0) after 1m17s
[05:49:13.768] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:25:0)
[05:49:13.786] Build status: STARTED
[05:49:13.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:26:0) after 8m31s
[05:57:44.852] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:26:0)
[05:57:44.870] Build status: STARTED
[05:57:44.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:27:0) after 3m12s
[06:00:56.938] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:27:0)
[06:00:56.954] Build status: STARTED
[06:00:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:28:0) after 4m45s
[06:05:42.008] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:28:0)
[06:05:42.026] Build status: STARTED
[06:05:42.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:29:0) after 3m20s
[06:09:02.050] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:29:0)
[06:09:02.068] Build status: STARTED
[06:09:02.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:30:0) after 1m1s
[06:10:03.086] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:30:0)
[06:10:03.177] Build status: STARTED
[06:10:03.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:31:0) after 1m15s
[06:11:18.239] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:31:0)
[06:11:18.267] Build status: STARTED
[06:11:18.267] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:32:0) after 6m42s
[06:18:00.292] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:32:0)
[06:18:00.313] Build status: STARTED
[06:18:00.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:33:0) after 5m47s
[06:23:47.331] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:33:0)
[06:23:47.358] Build status: STARTED
[06:23:47.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:34:0) after 3m24s
[06:27:11.428] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:34:0)
[06:27:11.464] Build status: STARTED
[06:27:11.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:35:0) after 4m42s
[06:31:53.803] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:35:0)
[06:31:53.824] Build status: STARTED
[06:31:53.824] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:36:0) after 6m41s
[06:38:35.172] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:36:0)
[06:38:35.222] Build status: STARTED
[06:38:35.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:37:0) after 8m57s
[06:47:32.242] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:37:0)
[06:47:32.258] Build status: STARTED
[06:47:32.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:38:0) after 6m36s
[06:54:08.470] Handling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:38:0)
[06:54:08.485] Build status: STARTED
[06:54:08.485] Scheduling timer "check-buildbucket-build-status" (chromium/linux-fuzz-coverage:8897479641524285488:39:0) after 4m39s
[06:54:38.484] Received PubSub notification, asking Buildbucket for the build status
[06:54:38.504] Build:
{
"id": "8732049579137193857",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "linux-fuzz-coverage"
},
"number": 753,
"createdBy": "project:chromium",
"createTime": "2024-11-06T04:00:08.998327973Z",
"startTime": "2024-11-06T04:45:31.110235983Z",
"endTime": "2024-11-06T06:54:38.093162219Z",
"updateTime": "2024-11-06T06:54:38.093162219Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d4631ac72e5b6fac2dc454ff15a9d162b8c7fc4f",
"ref": "refs/heads/main"
}
}
}
[06:54:38.504] Invocation finished in 2h54m31.166536865s with status SUCCEEDED