[19:44:29.198] New invocation is queued and will start shortly
[19:44:30.972] Starting the invocation (attempt 1)
[19:44:31.001] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc266f8dc7a3a3021f70bc466177c3a907cc40a2"
[19:44:31.001] Popped gitiles commit info from properties and tags
[19:44:31.001] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:44:31.001] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:44:31.001] Buildbucket request:
{
"requestId": "8882290533877395568",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dc266f8dc7a3a3021f70bc466177c3a907cc40a2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882290533877395568"
},
{
"key": "scheduler_job_id",
"value": "chromium/android-build-perf-developer"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:44:31.463] Scheduled build:
{
"id": "8716860471263286017",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 4524,
"createdBy": "project:chromium",
"createTime": "2025-04-22T19:44:31.067122737Z",
"updateTime": "2025-04-22T19:44:31.067122737Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dc266f8dc7a3a3021f70bc466177c3a907cc40a2",
"ref": "refs/heads/main"
}
}
}
[19:44:31.463] Task URL: https://cr-buildbucket.appspot.com/build/8716860471263286017
[19:44:31.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:2:0) after 6m12s
[19:44:32.462] Received PubSub notification, asking Buildbucket for the build status
[19:44:32.508] Build status: SCHEDULED
[19:44:35.051] Received PubSub notification, asking Buildbucket for the build status
[19:44:35.072] Build status: STARTED
[19:50:43.483] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:2:0)
[19:50:43.506] Build status: STARTED
[19:50:43.506] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:5:0) after 7m15s
[19:57:58.530] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:5:0)
[19:57:58.556] Build status: STARTED
[19:57:58.556] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:6:0) after 7m38s
[20:05:36.674] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:6:0)
[20:05:36.693] Build status: STARTED
[20:05:36.693] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:7:0) after 2m23s
[20:07:59.755] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:7:0)
[20:07:59.803] Build status: STARTED
[20:07:59.803] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:8:0) after 5m38s
[20:13:37.835] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:8:0)
[20:13:37.898] Build status: STARTED
[20:13:37.898] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:9:0) after 3m9s
[20:16:46.968] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:9:0)
[20:16:46.988] Build status: STARTED
[20:16:46.988] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:10:0) after 6m29s
[20:23:16.040] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:10:0)
[20:23:16.070] Build status: STARTED
[20:23:16.070] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:11:0) after 3m58s
[20:27:14.145] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:11:0)
[20:27:14.175] Build status: STARTED
[20:27:14.175] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:12:0) after 5m58s
[20:33:12.208] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:12:0)
[20:33:12.245] Build status: STARTED
[20:33:12.245] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:13:0) after 4m39s
[20:37:51.272] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:13:0)
[20:37:51.364] Build status: STARTED
[20:37:51.364] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:14:0) after 3m26s
[20:41:17.393] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:14:0)
[20:41:17.421] Build status: STARTED
[20:41:17.421] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:15:0) after 5m28s
[20:46:45.589] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:15:0)
[20:46:45.649] Build status: STARTED
[20:46:45.649] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:16:0) after 1m58s
[20:48:43.675] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:16:0)
[20:48:43.690] Build status: STARTED
[20:48:43.690] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:17:0) after 9m2s
[20:57:45.711] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:17:0)
[20:57:45.728] Build status: STARTED
[20:57:45.728] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:18:0) after 3m31s
[21:01:16.801] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:18:0)
[21:01:16.830] Build status: STARTED
[21:01:16.830] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:19:0) after 4m52s
[21:06:08.857] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:19:0)
[21:06:08.874] Build status: STARTED
[21:06:08.874] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:20:0) after 6m54s
[21:13:02.912] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:20:0)
[21:13:02.973] Build status: STARTED
[21:13:02.973] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:21:0) after 2m28s
[21:15:30.984] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:21:0)
[21:15:31.008] Build status: STARTED
[21:15:31.008] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:22:0) after 1m7s
[21:16:38.046] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:22:0)
[21:16:38.063] Build status: STARTED
[21:16:38.063] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:23:0) after 8m29s
[21:25:07.239] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:23:0)
[21:25:07.268] Build status: STARTED
[21:25:07.268] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:24:0) after 9m33s
[21:34:40.372] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:24:0)
[21:34:40.386] Build status: STARTED
[21:34:40.386] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:25:0) after 9m30s
[21:44:10.439] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:25:0)
[21:44:10.484] Build status: STARTED
[21:44:10.484] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:26:0) after 2m1s
[21:46:11.609] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:26:0)
[21:46:11.682] Build status: STARTED
[21:46:11.682] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:27:0) after 9m47s
[21:55:58.886] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:27:0)
[21:55:58.901] Build status: STARTED
[21:55:58.901] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:28:0) after 2m29s
[21:58:27.941] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:28:0)
[21:58:27.962] Build status: STARTED
[21:58:27.962] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:29:0) after 5m17s
[22:03:45.037] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:29:0)
[22:03:45.097] Build status: STARTED
[22:03:45.097] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:30:0) after 2m44s
[22:06:29.068] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:30:0)
[22:06:29.094] Build status: STARTED
[22:06:29.094] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:31:0) after 4m48s
[22:11:17.183] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:31:0)
[22:11:17.208] Build status: STARTED
[22:11:17.208] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:32:0) after 5m16s
[22:16:33.230] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:32:0)
[22:16:33.290] Build status: STARTED
[22:16:33.290] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:33:0) after 5m26s
[22:21:59.368] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:33:0)
[22:21:59.434] Build status: STARTED
[22:21:59.434] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:34:0) after 9m56s
[22:31:55.431] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:34:0)
[22:31:55.475] Build status: STARTED
[22:31:55.476] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:35:0) after 9m55s
[22:41:50.518] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:35:0)
[22:41:50.534] Build status: STARTED
[22:41:50.534] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:36:0) after 4m59s
[22:46:49.589] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:36:0)
[22:46:49.705] Build status: STARTED
[22:46:49.705] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:37:0) after 9m3s
[22:55:52.736] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:37:0)
[22:55:52.762] Build status: STARTED
[22:55:52.762] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:38:0) after 3m32s
[22:59:24.788] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:38:0)
[22:59:24.807] Build status: STARTED
[22:59:24.807] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:39:0) after 2m22s
[23:01:46.828] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:39:0)
[23:01:46.853] Build status: STARTED
[23:01:46.853] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:40:0) after 2m32s
[23:04:18.872] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:40:0)
[23:04:18.936] Build status: STARTED
[23:04:18.936] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:41:0) after 8m38s
[23:12:57.031] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:41:0)
[23:12:57.075] Build status: STARTED
[23:12:57.075] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:42:0) after 8m37s
[23:21:34.143] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:42:0)
[23:21:34.173] Build status: STARTED
[23:21:34.173] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:43:0) after 6m14s
[23:27:48.226] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:43:0)
[23:27:48.300] Build status: STARTED
[23:27:48.300] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:44:0) after 8m42s
[23:36:30.330] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:44:0)
[23:36:30.384] Build status: STARTED
[23:36:30.384] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:45:0) after 9m2s
[23:45:32.448] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:45:0)
[23:45:32.463] Build status: STARTED
[23:45:32.463] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:46:0) after 3m11s
[23:48:43.489] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:46:0)
[23:48:43.504] Build status: STARTED
[23:48:43.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8882290533877395568:47:0) after 4m49s
[23:50:31.996] Received PubSub notification, asking Buildbucket for the build status
[23:50:32.027] Build:
{
"id": "8716860471263286017",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 4524,
"createdBy": "project:chromium",
"createTime": "2025-04-22T19:44:31.067122737Z",
"startTime": "2025-04-22T19:44:34.819206133Z",
"endTime": "2025-04-22T23:50:29.875192610Z",
"updateTime": "2025-04-22T23:50:29.875192610Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "dc266f8dc7a3a3021f70bc466177c3a907cc40a2",
"ref": "refs/heads/main"
}
}
}
[23:50:32.027] Invocation finished in 4h6m2.837026448s with status SUCCEEDED