[13:36:20.683] New invocation is queued and will start shortly
[13:36:21.751] Starting the invocation (attempt 1)
[13:36:21.778] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/08febcd780dd3d667e56aecfcdbf7170a09360ce"
[13:36:21.778] Popped gitiles commit info from properties and tags
[13:36:21.778] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:36:21.779] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:36:21.779] Buildbucket request:
{
"requestId": "8947543511170831120",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "08febcd780dd3d667e56aecfcdbf7170a09360ce",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8947543511170831120"
},
{
"key": "scheduler_job_id",
"value": "chromium/Libfuzzer Upload Linux ASan Debug"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[13:36:22.460] Scheduled build:
{
"id": "8782113449234219681",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 137036,
"createdBy": "project:chromium",
"createTime": "2023-05-03T13:36:21.907877572Z",
"updateTime": "2023-05-03T13:36:21.907877572Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "08febcd780dd3d667e56aecfcdbf7170a09360ce",
"ref": "refs/heads/main"
}
}
}
[13:36:22.460] Task URL: https://cr-buildbucket.appspot.com/build/8782113449234219681
[13:36:22.460] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:2:0) after 7m9s
[13:36:32.019] Received PubSub notification, asking Buildbucket for the build status
[13:36:32.062] Build status: STARTED
[13:43:31.803] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:2:0)
[13:43:31.832] Build status: STARTED
[13:43:31.832] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:4:0) after 1m26s
[13:44:57.915] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:4:0)
[13:44:57.958] Build status: STARTED
[13:44:57.958] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:5:0) after 4m24s
[13:49:22.113] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:5:0)
[13:49:22.174] Build status: STARTED
[13:49:22.174] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:6:0) after 8m29s
[13:57:51.197] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:6:0)
[13:57:51.221] Build status: STARTED
[13:57:51.221] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:7:0) after 3m38s
[14:01:29.502] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:7:0)
[14:01:29.532] Build status: STARTED
[14:01:29.532] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:8:0) after 8m48s
[14:10:17.833] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:8:0)
[14:10:17.858] Build status: STARTED
[14:10:17.858] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:9:0) after 4m57s
[14:15:14.884] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:9:0)
[14:15:14.924] Build status: STARTED
[14:15:14.925] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:10:0) after 4m57s
[14:20:12.131] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:10:0)
[14:20:12.152] Build status: STARTED
[14:20:12.152] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:11:0) after 1m20s
[14:21:32.260] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:11:0)
[14:21:32.296] Build status: STARTED
[14:21:32.296] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:12:0) after 4m33s
[14:26:06.217] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:12:0)
[14:26:06.242] Build status: STARTED
[14:26:06.242] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:13:0) after 8m39s
[14:34:45.258] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:13:0)
[14:34:45.281] Build status: STARTED
[14:34:45.281] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:14:0) after 9m11s
[14:43:56.396] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:14:0)
[14:43:56.418] Build status: STARTED
[14:43:56.418] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:15:0) after 2m16s
[14:46:12.431] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:15:0)
[14:46:12.456] Build status: STARTED
[14:46:12.456] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:16:0) after 6m31s
[14:52:43.869] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:16:0)
[14:52:43.893] Build status: STARTED
[14:52:43.893] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:17:0) after 4m48s
[14:57:31.916] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:17:0)
[14:57:31.939] Build status: STARTED
[14:57:31.939] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:18:0) after 7m28s
[15:05:00.258] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:18:0)
[15:05:00.294] Build status: STARTED
[15:05:00.294] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:19:0) after 4m6s
[15:09:06.676] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:19:0)
[15:09:06.699] Build status: STARTED
[15:09:06.699] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:20:0) after 2m47s
[15:11:53.716] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:20:0)
[15:11:53.740] Build status: STARTED
[15:11:53.740] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:21:0) after 5m11s
[15:17:04.721] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:21:0)
[15:17:04.751] Build status: STARTED
[15:17:04.751] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:22:0) after 7m0s
[15:24:04.768] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:22:0)
[15:24:04.788] Build status: STARTED
[15:24:04.788] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:23:0) after 4m26s
[15:28:31.110] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:23:0)
[15:28:31.135] Build status: STARTED
[15:28:31.135] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:24:0) after 3m29s
[15:32:00.166] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:24:0)
[15:32:00.183] Build status: STARTED
[15:32:00.183] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:25:0) after 6m26s
[15:38:26.804] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:25:0)
[15:38:26.823] Build status: STARTED
[15:38:26.823] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:26:0) after 1m11s
[15:39:37.866] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:26:0)
[15:39:37.895] Build status: STARTED
[15:39:37.895] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:27:0) after 8m47s
[15:48:24.898] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:27:0)
[15:48:24.961] Build status: STARTED
[15:48:24.961] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:28:0) after 8m5s
[15:56:29.976] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:28:0)
[15:56:30.011] Build status: STARTED
[15:56:30.011] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:29:0) after 9m8s
[16:05:38.020] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:29:0)
[16:05:38.119] Build status: STARTED
[16:05:38.119] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:30:0) after 6m4s
[16:11:42.249] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:30:0)
[16:11:42.282] Build status: STARTED
[16:11:42.282] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:31:0) after 8m30s
[16:20:12.362] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:31:0)
[16:20:12.384] Build status: STARTED
[16:20:12.384] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8947543511170831120:32:0) after 4m42s
[16:21:55.827] Received PubSub notification, asking Buildbucket for the build status
[16:21:55.846] Build:
{
"id": "8782113449234219681",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 137036,
"createdBy": "project:chromium",
"createTime": "2023-05-03T13:36:21.907877572Z",
"startTime": "2023-05-03T13:36:31.335278Z",
"endTime": "2023-05-03T16:21:55.176934893Z",
"updateTime": "2023-05-03T16:21:55.176934893Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "08febcd780dd3d667e56aecfcdbf7170a09360ce",
"ref": "refs/heads/main"
}
}
}
[16:21:55.846] Invocation finished in 2h45m35.169459006s with status SUCCEEDED