[06:01:25.217] New invocation is queued and will start shortly
[06:01:26.279] Starting the invocation (attempt 1)
[06:01:26.312] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94182cf0a6d82aced210a79125eee8cf5ef020ba"
[06:01:26.312] Popped gitiles commit info from properties and tags
[06:01:26.312] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:01:26.312] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:01:26.312] Buildbucket request:
{
"requestId": "8931174081622467632",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94182cf0a6d82aced210a79125eee8cf5ef020ba",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8931174081622467632"
},
{
"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"
}
}
[06:01:26.993] Scheduled build:
{
"id": "8765744019631724305",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 145933,
"createdBy": "project:chromium",
"createTime": "2023-10-31T06:01:26.493160076Z",
"updateTime": "2023-10-31T06:01:26.493160076Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94182cf0a6d82aced210a79125eee8cf5ef020ba",
"ref": "refs/heads/main"
}
}
}
[06:01:26.993] Task URL: https://cr-buildbucket.appspot.com/build/8765744019631724305
[06:01:26.993] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:2:0) after 6m56s
[06:01:27.957] Received PubSub notification, asking Buildbucket for the build status
[06:01:27.979] Build status: SCHEDULED
[06:01:44.823] Received PubSub notification, asking Buildbucket for the build status
[06:01:44.887] Build status: STARTED
[06:08:23.007] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:2:0)
[06:08:23.055] Build status: STARTED
[06:08:23.055] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:5:0) after 9m14s
[06:17:37.084] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:5:0)
[06:17:37.103] Build status: STARTED
[06:17:37.103] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:6:0) after 1m49s
[06:19:26.142] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:6:0)
[06:19:26.171] Build status: STARTED
[06:19:26.171] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:7:0) after 6m22s
[06:25:48.186] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:7:0)
[06:25:48.364] Build status: STARTED
[06:25:48.365] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:8:0) after 2m53s
[06:28:41.380] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:8:0)
[06:28:41.411] Build status: STARTED
[06:28:41.411] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:9:0) after 2m6s
[06:30:47.666] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:9:0)
[06:30:47.823] Build status: STARTED
[06:30:47.823] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:10:0) after 5m27s
[06:36:14.841] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:10:0)
[06:36:14.868] Build status: STARTED
[06:36:14.868] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:11:0) after 6m35s
[06:42:49.965] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:11:0)
[06:42:50.012] Build status: STARTED
[06:42:50.012] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:12:0) after 3m53s
[06:46:43.031] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:12:0)
[06:46:43.067] Build status: STARTED
[06:46:43.067] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:13:0) after 6m34s
[06:53:17.091] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:13:0)
[06:53:17.123] Build status: STARTED
[06:53:17.123] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:14:0) after 2m17s
[06:55:34.138] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:14:0)
[06:55:34.155] Build status: STARTED
[06:55:34.155] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:15:0) after 8m30s
[07:04:04.290] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:15:0)
[07:04:04.327] Build status: STARTED
[07:04:04.327] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:16:0) after 2m25s
[07:06:29.447] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:16:0)
[07:06:29.468] Build status: STARTED
[07:06:29.469] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:17:0) after 8m42s
[07:15:11.498] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:17:0)
[07:15:11.527] Build status: STARTED
[07:15:11.527] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:18:0) after 3m20s
[07:18:31.691] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:18:0)
[07:18:31.710] Build status: STARTED
[07:18:31.710] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:19:0) after 5m58s
[07:24:29.827] Handling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:19:0)
[07:24:29.844] Build status: STARTED
[07:24:29.844] Scheduling timer "check-buildbucket-build-status" (chromium/Libfuzzer Upload Linux ASan Debug:8931174081622467632:20:0) after 7m21s
[07:27:56.545] Received PubSub notification, asking Buildbucket for the build status
[07:27:56.561] Build:
{
"id": "8765744019631724305",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Libfuzzer Upload Linux ASan Debug"
},
"number": 145933,
"createdBy": "project:chromium",
"createTime": "2023-10-31T06:01:26.493160076Z",
"startTime": "2023-10-31T06:01:43.640034Z",
"endTime": "2023-10-31T07:27:55.981493Z",
"updateTime": "2023-10-31T07:27:55.981493Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94182cf0a6d82aced210a79125eee8cf5ef020ba",
"ref": "refs/heads/main"
}
}
}
[07:27:56.561] Invocation finished in 1h26m31.350031179s with status SUCCEEDED