[09:01:44.288] New invocation is queued and will start shortly
[09:01:45.427] Starting the invocation (attempt 1)
[09:01:45.453] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/36b5627a5247893ed3cbfbc2fd569dc406b0b570"
[09:01:45.453] Popped gitiles commit info from properties and tags
[09:01:45.453] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:01:45.455] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:01:45.455] Buildbucket request:
{
"requestId": "8926814082623700048",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36b5627a5247893ed3cbfbc2fd569dc406b0b570",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8926814082623700048"
},
{
"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"
}
}
[09:01:46.583] Scheduled build:
{
"id": "8761384020490191393",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 291,
"createdBy": "project:chromium",
"createTime": "2023-12-18T09:01:45.694945599Z",
"updateTime": "2023-12-18T09:01:45.694945599Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36b5627a5247893ed3cbfbc2fd569dc406b0b570",
"ref": "refs/heads/main"
}
}
}
[09:01:46.583] Task URL: https://cr-buildbucket.appspot.com/build/8761384020490191393
[09:01:46.583] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:2:0) after 2m31s
[09:01:47.658] Received PubSub notification, asking Buildbucket for the build status
[09:01:47.684] Build status: SCHEDULED
[09:03:06.263] Received PubSub notification, asking Buildbucket for the build status
[09:03:06.296] Build status: STARTED
[09:04:17.701] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:2:0)
[09:04:17.731] Build status: STARTED
[09:04:17.731] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:5:0) after 7m10s
[09:11:27.747] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:5:0)
[09:11:27.763] Build status: STARTED
[09:11:27.763] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:6:0) after 8m2s
[09:19:29.785] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:6:0)
[09:19:29.819] Build status: STARTED
[09:19:29.819] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:7:0) after 7m20s
[09:26:50.030] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:7:0)
[09:26:50.078] Build status: STARTED
[09:26:50.078] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:8:0) after 3m57s
[09:30:47.154] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:8:0)
[09:30:47.217] Build status: STARTED
[09:30:47.217] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:9:0) after 4m17s
[09:35:04.479] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:9:0)
[09:35:04.507] Build status: STARTED
[09:35:04.507] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:10:0) after 7m34s
[09:42:38.570] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:10:0)
[09:42:38.644] Build status: STARTED
[09:42:38.644] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:11:0) after 5m48s
[09:48:26.861] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:11:0)
[09:48:26.915] Build status: STARTED
[09:48:26.915] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:12:0) after 7m35s
[09:56:02.309] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:12:0)
[09:56:02.351] Build status: STARTED
[09:56:02.351] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:13:0) after 9m40s
[10:05:42.576] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:13:0)
[10:05:42.625] Build status: STARTED
[10:05:42.625] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:14:0) after 3m57s
[10:09:39.708] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:14:0)
[10:09:39.738] Build status: STARTED
[10:09:39.738] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:15:0) after 6m1s
[10:15:40.771] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:15:0)
[10:15:40.793] Build status: STARTED
[10:15:40.793] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:16:0) after 5m30s
[10:21:10.936] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:16:0)
[10:21:10.985] Build status: STARTED
[10:21:10.985] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:17:0) after 6m39s
[10:27:50.161] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:17:0)
[10:27:50.184] Build status: STARTED
[10:27:50.184] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:18:0) after 3m17s
[10:31:07.191] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:18:0)
[10:31:07.232] Build status: STARTED
[10:31:07.232] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:19:0) after 3m27s
[10:34:34.248] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:19:0)
[10:34:34.271] Build status: STARTED
[10:34:34.271] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:20:0) after 2m8s
[10:36:42.413] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:20:0)
[10:36:42.435] Build status: STARTED
[10:36:42.435] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:21:0) after 8m15s
[10:44:57.701] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:21:0)
[10:44:57.730] Build status: STARTED
[10:44:57.730] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:22:0) after 5m7s
[10:50:04.755] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:22:0)
[10:50:04.801] Build status: STARTED
[10:50:04.801] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:23:0) after 2m50s
[10:52:54.820] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:23:0)
[10:52:54.837] Build status: STARTED
[10:52:54.837] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:24:0) after 9m44s
[11:02:38.855] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:24:0)
[11:02:38.876] Build status: STARTED
[11:02:38.876] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:25:0) after 2m53s
[11:05:32.099] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:25:0)
[11:05:32.126] Build status: STARTED
[11:05:32.126] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:26:0) after 2m56s
[11:08:28.316] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:26:0)
[11:08:28.344] Build status: STARTED
[11:08:28.344] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:27:0) after 3m15s
[11:11:43.476] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:27:0)
[11:11:43.504] Build status: STARTED
[11:11:43.504] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:28:0) after 1m56s
[11:13:39.526] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:28:0)
[11:13:39.560] Build status: STARTED
[11:13:39.560] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:29:0) after 4m34s
[11:18:13.744] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:29:0)
[11:18:13.802] Build status: STARTED
[11:18:13.802] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:30:0) after 1m59s
[11:20:12.825] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:30:0)
[11:20:12.952] Build status: STARTED
[11:20:12.952] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:31:0) after 7m10s
[11:27:23.011] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:31:0)
[11:27:23.039] Build status: STARTED
[11:27:23.039] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:32:0) after 4m54s
[11:32:17.070] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:32:0)
[11:32:17.112] Build status: STARTED
[11:32:17.112] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:33:0) after 6m13s
[11:38:30.463] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:33:0)
[11:38:30.489] Build status: STARTED
[11:38:30.490] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:34:0) after 4m29s
[11:42:59.509] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:34:0)
[11:42:59.529] Build status: STARTED
[11:42:59.529] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:35:0) after 6m26s
[11:49:25.609] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:35:0)
[11:49:25.656] Build status: STARTED
[11:49:25.656] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:36:0) after 7m43s
[11:57:08.689] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:36:0)
[11:57:08.752] Build status: STARTED
[11:57:08.752] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:37:0) after 9m32s
[12:06:40.868] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:37:0)
[12:06:40.886] Build status: STARTED
[12:06:40.886] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:38:0) after 4m35s
[12:11:16.005] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:38:0)
[12:11:16.038] Build status: STARTED
[12:11:16.038] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:39:0) after 7m6s
[12:18:22.216] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:39:0)
[12:18:22.248] Build status: STARTED
[12:18:22.248] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:40:0) after 3m23s
[12:21:45.267] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:40:0)
[12:21:45.287] Build status: STARTED
[12:21:45.288] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:41:0) after 1m22s
[12:23:07.472] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:41:0)
[12:23:07.517] Build status: STARTED
[12:23:07.517] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:42:0) after 8m14s
[12:31:21.561] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:42:0)
[12:31:21.593] Build status: STARTED
[12:31:21.593] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:43:0) after 4m34s
[12:35:55.607] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:43:0)
[12:35:55.626] Build status: STARTED
[12:35:55.626] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:44:0) after 5m52s
[12:41:47.717] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:44:0)
[12:41:47.740] Build status: STARTED
[12:41:47.740] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:45:0) after 3m29s
[12:45:16.863] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:45:0)
[12:45:16.903] Build status: STARTED
[12:45:16.903] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:46:0) after 8m31s
[12:53:47.934] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:46:0)
[12:53:48.051] Build status: STARTED
[12:53:48.051] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:47:0) after 1m35s
[12:55:23.076] Handling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:47:0)
[12:55:23.160] Build status: STARTED
[12:55:23.160] Scheduling timer "check-buildbucket-build-status" (chromium/android-build-perf-developer:8926814082623700048:48:0) after 4m17s
[12:57:33.967] Received PubSub notification, asking Buildbucket for the build status
[12:57:34.000] Build:
{
"id": "8761384020490191393",
"builder": {
"project": "chromium",
"bucket": "build",
"builder": "android-build-perf-developer"
},
"number": 291,
"createdBy": "project:chromium",
"createTime": "2023-12-18T09:01:45.694945599Z",
"startTime": "2023-12-18T09:03:05.665814Z",
"endTime": "2023-12-18T12:57:31.220916Z",
"updateTime": "2023-12-18T12:57:31.220916Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "36b5627a5247893ed3cbfbc2fd569dc406b0b570",
"ref": "refs/heads/main"
}
}
}
[12:57:34.000] Invocation finished in 3h55m49.724590638s with status SUCCEEDED