[07:01:26.826] New invocation is queued and will start shortly
[07:01:28.006] Starting the invocation (attempt 1)
[07:01:28.033] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a561451f65cf7ff5e325cd5ff3724ee0c8b7bd39"
[07:01:28.033] Popped gitiles commit info from properties and tags
[07:01:28.033] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:01:28.034] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:01:28.034] Buildbucket request:
{
"requestId": "8946934177223860608",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a561451f65cf7ff5e325cd5ff3724ee0c8b7bd39",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8946934177223860608"
},
{
"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"
}
}
[07:01:29.073] Scheduled build:
{
"id": "8781504115122065457",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 137315,
"createdBy": "project:chromium",
"createTime": "2023-05-10T07:01:28.200435372Z",
"updateTime": "2023-05-10T07:01:28.200435372Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a561451f65cf7ff5e325cd5ff3724ee0c8b7bd39",
"ref": "refs/heads/main"
}
}
}
[07:01:29.073] Task URL: https://cr-buildbucket.appspot.com/build/8781504115122065457
[07:01:29.073] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:2:0) after 8m40s
[07:04:19.370] Received PubSub notification, asking Buildbucket for the build status
[07:04:19.390] Build status: STARTED
[07:10:09.216] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:2:0)
[07:10:09.236] Build status: STARTED
[07:10:09.236] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:4:0) after 6m14s
[07:16:23.481] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:4:0)
[07:16:23.518] Build status: STARTED
[07:16:23.518] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:5:0) after 6m19s
[07:22:42.607] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:5:0)
[07:22:42.639] Build status: STARTED
[07:22:42.639] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:6:0) after 1m52s
[07:24:34.656] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:6:0)
[07:24:34.674] Build status: STARTED
[07:24:34.674] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:7:0) after 2m13s
[07:26:47.849] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:7:0)
[07:26:47.870] Build status: STARTED
[07:26:47.870] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:8:0) after 3m2s
[07:29:50.026] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:8:0)
[07:29:50.052] Build status: STARTED
[07:29:50.052] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:9:0) after 1m17s
[07:31:07.264] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:9:0)
[07:31:07.292] Build status: STARTED
[07:31:07.292] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:10:0) after 5m3s
[07:36:10.438] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:10:0)
[07:36:10.469] Build status: STARTED
[07:36:10.469] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:11:0) after 8m33s
[07:44:43.572] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:11:0)
[07:44:43.597] Build status: STARTED
[07:44:43.597] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:12:0) after 7m52s
[07:52:35.614] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:12:0)
[07:52:35.632] Build status: STARTED
[07:52:35.632] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:13:0) after 6m36s
[07:59:11.651] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:13:0)
[07:59:11.671] Build status: STARTED
[07:59:11.671] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:14:0) after 6m50s
[08:06:01.697] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:14:0)
[08:06:01.724] Build status: STARTED
[08:06:01.724] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:15:0) after 3m12s
[08:09:13.774] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:15:0)
[08:09:13.834] Build status: STARTED
[08:09:13.834] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:16:0) after 7m4s
[08:16:18.443] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:16:0)
[08:16:18.461] Build status: STARTED
[08:16:18.461] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:17:0) after 6m36s
[08:22:54.917] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:17:0)
[08:22:54.935] Build status: STARTED
[08:22:54.935] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:18:0) after 3m51s
[08:26:46.151] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:18:0)
[08:26:46.173] Build status: STARTED
[08:26:46.173] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:19:0) after 5m30s
[08:32:16.521] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:19:0)
[08:32:16.544] Build status: STARTED
[08:32:16.544] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:20:0) after 6m56s
[08:39:12.641] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:20:0)
[08:39:12.659] Build status: STARTED
[08:39:12.659] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:21:0) after 9m51s
[08:49:04.014] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:21:0)
[08:49:04.036] Build status: STARTED
[08:49:04.036] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:22:0) after 6m55s
[08:55:59.073] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:22:0)
[08:55:59.107] Build status: STARTED
[08:55:59.107] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:23:0) after 9m5s
[09:05:04.278] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:23:0)
[09:05:04.300] Build status: STARTED
[09:05:04.300] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:24:0) after 7m36s
[09:12:40.390] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:24:0)
[09:12:40.411] Build status: STARTED
[09:12:40.411] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:25:0) after 3m29s
[09:16:09.454] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:25:0)
[09:16:09.493] Build status: STARTED
[09:16:09.493] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:26:0) after 2m32s
[09:18:41.642] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:26:0)
[09:18:41.660] Build status: STARTED
[09:18:41.660] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:27:0) after 6m34s
[09:25:15.687] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:27:0)
[09:25:15.707] Build status: STARTED
[09:25:15.707] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:28:0) after 8m20s
[09:33:35.721] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:28:0)
[09:33:35.740] Build status: STARTED
[09:33:35.740] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:29:0) after 6m13s
[09:39:48.796] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:29:0)
[09:39:48.819] Build status: STARTED
[09:39:48.819] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8946934177223860608:30:0) after 9m28s
[09:47:23.309] Received PubSub notification, asking Buildbucket for the build status
[09:47:23.424] Build:
{
"id": "8781504115122065457",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 137315,
"createdBy": "project:chromium",
"createTime": "2023-05-10T07:01:28.200435372Z",
"startTime": "2023-05-10T07:04:18.524104Z",
"endTime": "2023-05-10T09:47:22.963817258Z",
"updateTime": "2023-05-10T09:47:22.963817258Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a561451f65cf7ff5e325cd5ff3724ee0c8b7bd39",
"ref": "refs/heads/main"
}
}
}
[09:47:23.424] Invocation finished in 2h45m56.612129827s with status SUCCEEDED