[00:21:00.117] New invocation is queued and will start shortly
[00:21:01.196] Starting the invocation (attempt 1)
[00:21:01.225] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c983a33322d042589774a3ea46aa698989d3eec4"
[00:21:01.225] Popped gitiles commit info from properties and tags
[00:21:01.225] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:21:01.225] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:21:01.225] Buildbucket request:
{
"requestId": "8949224295206032400",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Android (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c983a33322d042589774a3ea46aa698989d3eec4",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8949224295206032400"
},
{
"key": "scheduler_job_id",
"value": "chromium/Deterministic Android (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[00:21:01.691] Scheduled build:
{
"id": "8783794233327478001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Android (dbg)"
},
"number": 13314,
"createdBy": "project:chromium",
"createTime": "2023-04-15T00:21:01.286409958Z",
"updateTime": "2023-04-15T00:21:01.286409958Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c983a33322d042589774a3ea46aa698989d3eec4",
"ref": "refs/heads/main"
}
}
}
[00:21:01.691] Task URL: https://cr-buildbucket.appspot.com/build/8783794233327478001
[00:21:01.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:2:0) after 4m40s
[00:22:03.558] Received PubSub notification, asking Buildbucket for the build status
[00:22:03.603] Build status: STARTED
[00:25:42.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:2:0)
[00:25:42.028] Build status: STARTED
[00:25:42.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:4:0) after 3m42s
[00:29:24.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:4:0)
[00:29:24.313] Build status: STARTED
[00:29:24.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:5:0) after 1m30s
[00:30:54.341] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:5:0)
[00:30:54.365] Build status: STARTED
[00:30:54.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:6:0) after 7m45s
[00:38:39.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:6:0)
[00:38:39.529] Build status: STARTED
[00:38:39.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:7:0) after 7m42s
[00:46:21.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:7:0)
[00:46:21.573] Build status: STARTED
[00:46:21.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:8:0) after 7m31s
[00:53:52.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:8:0)
[00:53:52.637] Build status: STARTED
[00:53:52.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:9:0) after 6m20s
[01:00:12.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:9:0)
[01:00:12.687] Build status: STARTED
[01:00:12.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:10:0) after 6m6s
[01:06:18.732] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:10:0)
[01:06:18.811] Build status: STARTED
[01:06:18.811] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:11:0) after 2m38s
[01:08:56.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:11:0)
[01:08:56.826] Build status: STARTED
[01:08:56.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:12:0) after 3m16s
[01:12:13.080] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:12:0)
[01:12:13.101] Build status: STARTED
[01:12:13.101] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:13:0) after 5m36s
[01:17:49.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:13:0)
[01:17:49.256] Build status: STARTED
[01:17:49.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:14:0) after 7m47s
[01:25:36.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:14:0)
[01:25:36.471] Build status: STARTED
[01:25:36.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:15:0) after 8m33s
[01:34:09.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:15:0)
[01:34:09.515] Build status: STARTED
[01:34:09.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:16:0) after 7m51s
[01:42:00.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:16:0)
[01:42:00.623] Build status: STARTED
[01:42:00.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:17:0) after 8m5s
[01:50:05.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:17:0)
[01:50:05.674] Build status: STARTED
[01:50:05.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:18:0) after 4m33s
[01:54:38.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:18:0)
[01:54:38.710] Build status: STARTED
[01:54:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:19:0) after 9m9s
[02:03:47.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:19:0)
[02:03:47.993] Build status: STARTED
[02:03:47.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:20:0) after 4m48s
[02:08:36.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:20:0)
[02:08:36.040] Build status: STARTED
[02:08:36.040] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:21:0) after 3m33s
[02:12:09.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:21:0)
[02:12:09.092] Build status: STARTED
[02:12:09.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:22:0) after 9m48s
[02:21:57.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:22:0)
[02:21:57.282] Build status: STARTED
[02:21:57.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:23:0) after 5m29s
[02:27:26.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:23:0)
[02:27:26.367] Build status: STARTED
[02:27:26.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:24:0) after 9m55s
[02:37:21.553] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:24:0)
[02:37:21.577] Build status: STARTED
[02:37:21.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:25:0) after 3m42s
[02:41:03.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:25:0)
[02:41:03.688] Build status: STARTED
[02:41:03.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:26:0) after 5m16s
[02:46:19.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:26:0)
[02:46:19.824] Build status: STARTED
[02:46:19.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:27:0) after 6m20s
[02:52:39.846] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:27:0)
[02:52:39.869] Build status: STARTED
[02:52:39.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:28:0) after 5m4s
[02:57:43.963] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:28:0)
[02:57:43.982] Build status: STARTED
[02:57:43.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:29:0) after 1m17s
[02:59:01.008] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:29:0)
[02:59:01.068] Build status: STARTED
[02:59:01.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:30:0) after 3m57s
[03:02:58.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:30:0)
[03:02:58.138] Build status: STARTED
[03:02:58.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:31:0) after 1m23s
[03:04:21.223] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:31:0)
[03:04:21.245] Build status: STARTED
[03:04:21.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:32:0) after 4m54s
[03:09:15.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:32:0)
[03:09:15.286] Build status: STARTED
[03:09:15.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:33:0) after 4m7s
[03:13:22.313] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:33:0)
[03:13:22.332] Build status: STARTED
[03:13:22.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:34:0) after 5m0s
[03:18:22.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:34:0)
[03:18:22.567] Build status: STARTED
[03:18:22.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:35:0) after 9m18s
[03:27:40.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:35:0)
[03:27:40.699] Build status: STARTED
[03:27:40.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:36:0) after 4m2s
[03:31:42.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:36:0)
[03:31:42.941] Build status: STARTED
[03:31:42.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):8949224295206032400:37:0) after 9m45s
[03:38:00.594] Received PubSub notification, asking Buildbucket for the build status
[03:38:00.617] Build:
{
"id": "8783794233327478001",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Android (dbg)"
},
"number": 13314,
"createdBy": "project:chromium",
"createTime": "2023-04-15T00:21:01.286409958Z",
"startTime": "2023-04-15T00:22:03.100831Z",
"endTime": "2023-04-15T03:38:00.352679379Z",
"updateTime": "2023-04-15T03:38:00.352679379Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c983a33322d042589774a3ea46aa698989d3eec4",
"ref": "refs/heads/main"
}
}
}
[03:38:00.617] Invocation finished in 3h17m0.50532385s with status SUCCEEDED