[43.899893] Initializing watchdogs
[43.900258]   /dev/watchdog0
[43.909772] [001/165] (960s left) i915_module_load (load)
[43.959907] Starting subtest: load
[45.508565] Subtest load: SUCCESS (1.549s)
[45.533215] [002/165] (958s left) core_auth (basic-auth)
[45.628873] Starting subtest: basic-auth
[45.631953] Subtest basic-auth: SUCCESS (0.000s)
[45.690630] [003/165] (958s left) debugfs_test (read_all_entries)
[45.759685] Starting subtest: read_all_entries
[45.875646] Subtest read_all_entries: SUCCESS (0.118s)
[45.974775] [004/165] (958s left) debugfs_test (basic-hwmon)
[46.041478] Starting subtest: basic-hwmon
[46.047829] Subtest basic-hwmon: SKIP (0.000s)
[46.151660] [005/165] (958s left) fbdev (eof)
[46.242763] Starting subtest: eof
[46.246513] Subtest eof: SUCCESS (0.000s)
[46.290605] [006/165] (958s left) fbdev (info)
[46.360570] Starting subtest: info
[46.364100] Subtest info: SUCCESS (0.000s)
[46.426706] [007/165] (958s left) fbdev (nullptr)
[46.492037] Starting subtest: nullptr
[46.495092] Subtest nullptr: SUCCESS (0.000s)
[46.543021] [008/165] (958s left) fbdev (read)
[46.593323] Starting subtest: read
[46.807670] Subtest read: SUCCESS (0.216s)
[46.854672] [009/165] (957s left) fbdev (write)
[46.910191] Starting subtest: write
[47.023117] Subtest write: SUCCESS (0.114s)
[47.076600] [010/165] (957s left) gem_basic (bad-close)
[47.120736] Starting subtest: bad-close
[47.127069] Subtest bad-close: SUCCESS (0.000s)
[47.178047] [011/165] (957s left) gem_basic (create-close)
[47.266038] Starting subtest: create-close
[47.273155] Subtest create-close: SUCCESS (0.000s)
[47.356575] [012/165] (957s left) gem_basic (create-fd-close)
[47.413682] Starting subtest: create-fd-close
[47.420905] Subtest create-fd-close: SUCCESS (0.000s)
[47.494979] [013/165] (957s left) gem_busy (busy@all-engines)
[47.591113] Starting subtest: busy
[47.594271] Starting dynamic subtest: all-engines
[47.610708] Dynamic subtest all-engines: SUCCESS (0.021s)
[47.614217] Subtest busy: SUCCESS (0.022s)
[47.976312] [014/165] (956s left) gem_close_race (basic-process)
[48.068626] Starting subtest: basic-process
[48.113430] Subtest basic-process: SUCCESS (0.045s)
[48.283082] [015/165] (956s left) gem_close_race (basic-threads)
[48.337769] Starting subtest: basic-threads
[49.537590] Subtest basic-threads: SUCCESS (1.200s)
[49.754459] [016/165] (955s left) gem_ctx_create (basic)
[49.851082] Starting subtest: basic
[49.854153] Subtest basic: SUCCESS (0.000s)
[50.063422] [017/165] (954s left) gem_ctx_create (basic-files)
[50.150927] Starting subtest: basic-files
[52.159838] Subtest basic-files: SUCCESS (2.010s)
[52.404534] [018/165] (952s left) gem_ctx_exec (basic)
[52.462191] Starting subtest: basic
[52.465676] Subtest basic: SUCCESS (0.002s)
[52.596492] [019/165] (952s left) gem_exec_basic (basic)
[52.688439] Starting subtest: basic
[52.691770] Starting dynamic subtest: rcs0-smem
[52.695203] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[52.701947] Starting dynamic subtest: bcs0-smem
[52.705387] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[52.711855] Starting dynamic subtest: vcs0-smem
[52.715161] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[52.721925] Starting dynamic subtest: vecs0-smem
[52.725376] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[52.728926] Subtest basic: SUCCESS (0.002s)
[52.930413] [020/165] (952s left) gem_exec_create (basic)
[53.032661] Starting subtest: basic
[53.036171] Starting dynamic subtest: smem
[55.076516] Dynamic subtest smem: SUCCESS (2.043s)
[55.080308] Subtest basic: SUCCESS (2.044s)
[55.276625] [021/165] (949s left) gem_exec_fence (basic-busy)
[55.513730] Starting subtest: basic-busy
[55.518173] Starting dynamic subtest: rcs0
[55.548541] Dynamic subtest rcs0: SUCCESS (0.035s)
[55.572789] Starting dynamic subtest: bcs0
[55.585581] Dynamic subtest bcs0: SUCCESS (0.037s)
[55.608926] Starting dynamic subtest: vcs0
[55.625095] Dynamic subtest vcs0: SUCCESS (0.039s)
[55.641947] Starting dynamic subtest: vecs0
[55.657713] Dynamic subtest vecs0: SUCCESS (0.033s)
[55.661324] Subtest basic-busy: SUCCESS (0.145s)
[56.233825] [022/165] (948s left) gem_exec_fence (basic-wait)
[56.393684] Starting subtest: basic-wait
[56.396974] Starting dynamic subtest: rcs0
[56.437483] Dynamic subtest rcs0: SUCCESS (0.043s)
[56.461867] Starting dynamic subtest: bcs0
[56.478713] Dynamic subtest bcs0: SUCCESS (0.040s)
[56.502964] Starting dynamic subtest: vcs0
[56.517447] Dynamic subtest vcs0: SUCCESS (0.039s)
[56.541568] Starting dynamic subtest: vecs0
[56.552556] Dynamic subtest vecs0: SUCCESS (0.035s)
[56.556172] Subtest basic-wait: SUCCESS (0.159s)
[57.050715] [023/165] (948s left) gem_exec_fence (basic-await)
[57.209141] Starting subtest: basic-await
[57.212200] Starting dynamic subtest: rcs0
[57.280143] Dynamic subtest rcs0: SUCCESS (0.070s)
[57.294160] Starting dynamic subtest: bcs0
[57.370908] Dynamic subtest bcs0: SUCCESS (0.090s)
[57.386674] Starting dynamic subtest: vcs0
[57.459295] Dynamic subtest vcs0: SUCCESS (0.088s)
[57.468584] Starting dynamic subtest: vecs0
[57.536964] Dynamic subtest vecs0: SUCCESS (0.076s)
[57.541196] Subtest basic-await: SUCCESS (0.327s)
[58.098615] [024/165] (947s left) gem_exec_fence (nb-await)
[58.288399] Starting subtest: nb-await
[58.291550] Starting dynamic subtest: rcs0
[58.347061] Dynamic subtest rcs0: SUCCESS (0.058s)
[58.370622] Starting dynamic subtest: bcs0
[58.418246] Dynamic subtest bcs0: SUCCESS (0.070s)
[58.441831] Starting dynamic subtest: vcs0
[58.493502] Dynamic subtest vcs0: SUCCESS (0.075s)
[58.516528] Starting dynamic subtest: vecs0
[58.568137] Dynamic subtest vecs0: SUCCESS (0.074s)
[58.572465] Subtest nb-await: SUCCESS (0.279s)
[59.069685] [025/165] (946s left) gem_exec_gttfill (basic)
[59.161860] Starting subtest: basic
[63.977049] Subtest basic: SUCCESS (4.817s)
[64.140522] [026/165] (941s left) gem_exec_parallel (engines)
[64.252591] Starting subtest: engines
[64.255612] Starting dynamic subtest: basic
[65.641326] Dynamic subtest basic: SUCCESS (1.391s)
[65.648601] Starting dynamic subtest: contexts
[68.113031] Dynamic subtest contexts: SUCCESS (2.471s)
[68.120381] Starting dynamic subtest: fds
[70.466312] Dynamic subtest fds: SUCCESS (2.353s)
[70.473900] Starting dynamic subtest: userptr
[72.368163] Dynamic subtest userptr: SUCCESS (1.902s)
[72.371463] Subtest engines: SUCCESS (8.118s)
[72.574217] [027/165] (932s left) gem_exec_store (basic)
[72.670540] Starting subtest: basic
[72.711401] Subtest basic: SUCCESS (0.051s)
[72.883798] [028/165] (932s left) gem_flink_basic (bad-flink)
[72.931014] Starting subtest: bad-flink
[72.934447] Subtest bad-flink: SUCCESS (0.000s)
[72.998383] [029/165] (932s left) gem_flink_basic (bad-open)
[73.049521] Starting subtest: bad-open
[73.052739] Subtest bad-open: SUCCESS (0.000s)
[73.108485] [030/165] (932s left) gem_flink_basic (basic)
[73.163805] Starting subtest: basic
[73.167167] Subtest basic: SUCCESS (0.000s)
[73.245212] [031/165] (932s left) gem_flink_basic (double-flink)
[73.332197] Starting subtest: double-flink
[73.335720] Subtest double-flink: SUCCESS (0.000s)
[73.394731] [032/165] (931s left) gem_flink_basic (flink-lifetime)
[73.446444] Starting subtest: flink-lifetime
[73.449817] Subtest flink-lifetime: SUCCESS (0.001s)
[73.519836] [033/165] (931s left) gem_huc_copy (huc-copy)
[73.578713] Starting subtest: huc-copy
[73.582183] Subtest huc-copy: SUCCESS (0.002s)
[73.716712] [034/165] (931s left) gem_linear_blits (basic)
[73.857421] Starting subtest: basic
[73.865667] Subtest basic: SUCCESS (0.004s)
[74.021210] [035/165] (931s left) gem_mmap (basic)
[74.170530] Starting subtest: basic
[74.187585] Subtest basic: SUCCESS (0.000s)
[74.261364] [036/165] (931s left) gem_mmap_gtt (basic)
[74.367664] Starting subtest: basic
[74.371043] Subtest basic: SUCCESS (0.000s)
[74.419107] [037/165] (931s left) gem_render_linear_blits (basic)
[74.487321] Starting subtest: basic
[74.506309] Subtest basic: SUCCESS (0.019s)
[74.551694] [038/165] (930s left) gem_render_tiled_blits (basic)
[74.597540] Starting subtest: basic
[74.616414] Subtest basic: SUCCESS (0.020s)
[74.651635] [039/165] (930s left) gem_ringfill (basic-all)
[74.861841] Starting subtest: basic-all
[76.036144] Subtest basic-all: SUCCESS (1.140s)
[76.392686] [040/165] (929s left) gem_softpin (allocator-basic)
[76.924550] Starting subtest: allocator-basic
[76.994910] Subtest allocator-basic: SUCCESS (0.058s)
[77.284284] [041/165] (928s left) gem_softpin (allocator-basic-reserve)
[77.624642] Starting subtest: allocator-basic-reserve
[77.696153] Subtest allocator-basic-reserve: SUCCESS (0.060s)
[78.000366] [042/165] (928s left) gem_softpin (safe-alignment)
[78.338849] Starting subtest: safe-alignment
[78.405930] Subtest safe-alignment: SUCCESS (0.006s)
[78.641765] [043/165] (927s left) gem_sync (basic-all)
[79.546583] Starting subtest: basic-all
[81.151399] Subtest basic-all: SUCCESS (2.188s)
[81.326259] [044/165] (925s left) gem_sync (basic-each)
[81.391200] Starting subtest: basic-each
[83.451539] Subtest basic-each: SUCCESS (2.077s)
[83.670243] [045/165] (922s left) gem_tiled_blits (basic)
[83.808027] Starting subtest: basic
[83.820245] Subtest basic: SUCCESS (0.012s)
[83.979519] [046/165] (922s left) gem_tiled_fence_blits (basic)
[84.183381] Starting subtest: basic
[84.191209] Subtest basic: SUCCESS (0.006s)
[84.348764] [047/165] (922s left) gem_tiled_pread_basic
[84.678593] [048/165] (922s left) gem_wait (busy@all-engines)
[84.737995] Starting subtest: busy
[84.741241] Starting dynamic subtest: all-engines
[85.252142] Dynamic subtest all-engines: SUCCESS (0.514s)
[85.255446] Subtest busy: SUCCESS (0.514s)
[85.426457] [049/165] (921s left) gem_wait (wait@all-engines)
[85.478602] Starting subtest: wait
[85.481725] Starting dynamic subtest: all-engines
[86.506617] Dynamic subtest all-engines: SUCCESS (1.026s)
[86.511239] Subtest wait: SUCCESS (1.027s)
[86.693621] [050/165] (920s left) i915_getparams_basic (basic-eu-total)
[86.741093] Starting subtest: basic-eu-total
[86.747863] Subtest basic-eu-total: SUCCESS (0.000s)
[86.800889] [051/165] (920s left) i915_getparams_basic (basic-subslice-total)
[86.849230] Starting subtest: basic-subslice-total
[86.855881] Subtest basic-subslice-total: SUCCESS (0.000s)
[86.918539] [052/165] (919s left) i915_hangman (error-state-basic)
[87.013801] Starting subtest: error-state-basic
[87.063488] Subtest error-state-basic: SUCCESS (0.050s)
[87.151386] [053/165] (919s left) i915_pciid
[87.298441] [054/165] (919s left) kms_addfb_basic (addfb25-4-tiled)
[87.430113] Starting subtest: addfb25-4-tiled
[87.433195] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[87.513159] [055/165] (919s left) kms_addfb_basic (addfb25-bad-modifier)
[87.586269] Starting subtest: addfb25-bad-modifier
[87.589392] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[87.721073] [056/165] (919s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[87.777145] Starting subtest: addfb25-framebuffer-vs-set-tiling
[87.780465] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[87.927546] [057/165] (919s left) kms_addfb_basic (addfb25-modifier-no-flag)
[87.991469] Starting subtest: addfb25-modifier-no-flag
[87.994650] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[88.129117] [058/165] (918s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[88.184722] Starting subtest: addfb25-x-tiled-legacy
[88.187870] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[88.306205] [059/165] (918s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[88.351796] Starting subtest: addfb25-x-tiled-mismatch-legacy
[88.355243] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[88.456681] [060/165] (918s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[88.549631] Starting subtest: addfb25-yf-tiled-legacy
[88.552773] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[88.634083] [061/165] (918s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[88.768637] Starting subtest: addfb25-y-tiled-legacy
[88.771674] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[88.849173] [062/165] (918s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[88.949160] Starting subtest: addfb25-y-tiled-small-legacy
[88.952292] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[89.033033] [063/165] (918s left) kms_addfb_basic (bad-pitch-0)
[89.088082] Starting subtest: bad-pitch-0
[89.091331] Subtest bad-pitch-0: SUCCESS (0.000s)
[89.221033] [064/165] (918s left) kms_addfb_basic (bad-pitch-1024)
[89.278763] Starting subtest: bad-pitch-1024
[89.282301] Subtest bad-pitch-1024: SUCCESS (0.000s)
[89.399339] [065/165] (917s left) kms_addfb_basic (bad-pitch-128)
[89.479882] Starting subtest: bad-pitch-128
[89.483226] Subtest bad-pitch-128: SUCCESS (0.000s)
[89.633595] [066/165] (917s left) kms_addfb_basic (bad-pitch-256)
[89.714488] Starting subtest: bad-pitch-256
[89.717599] Subtest bad-pitch-256: SUCCESS (0.000s)
[89.851613] [067/165] (917s left) kms_addfb_basic (bad-pitch-32)
[89.907315] Starting subtest: bad-pitch-32
[89.910495] Subtest bad-pitch-32: SUCCESS (0.000s)
[90.030138] [068/165] (917s left) kms_addfb_basic (bad-pitch-63)
[90.102301] Starting subtest: bad-pitch-63
[90.105489] Subtest bad-pitch-63: SUCCESS (0.000s)
[90.233365] [069/165] (917s left) kms_addfb_basic (bad-pitch-65536)
[90.311008] Starting subtest: bad-pitch-65536
[90.313979] Subtest bad-pitch-65536: SUCCESS (0.000s)
[90.427962] [070/165] (917s left) kms_addfb_basic (bad-pitch-999)
[90.497601] Starting subtest: bad-pitch-999
[90.500533] Subtest bad-pitch-999: SUCCESS (0.000s)
[90.630441] [071/165] (916s left) kms_addfb_basic (basic)
[90.684164] Starting subtest: basic
[90.687786] Subtest basic: SUCCESS (0.000s)
[90.809239] [072/165] (916s left) kms_addfb_basic (basic-x-tiled-legacy)
[90.876094] Starting subtest: basic-x-tiled-legacy
[90.879082] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[90.999408] [073/165] (916s left) kms_addfb_basic (basic-y-tiled-legacy)
[91.079498] Starting subtest: basic-y-tiled-legacy
[91.082802] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[91.226057] [074/165] (916s left) kms_addfb_basic (bo-too-small)
[91.363685] Starting subtest: bo-too-small
[91.366852] Subtest bo-too-small: SUCCESS (0.000s)
[91.426412] [075/165] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[91.537342] Starting subtest: bo-too-small-due-to-tiling
[91.540416] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[91.612131] [076/165] (915s left) kms_addfb_basic (clobberred-modifier)
[91.663377] Starting subtest: clobberred-modifier
[91.666503] Subtest clobberred-modifier: SUCCESS (0.000s)
[91.806961] [077/165] (915s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[91.898856] Starting subtest: framebuffer-vs-set-tiling
[91.902166] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.034150] [078/165] (915s left) kms_addfb_basic (invalid-get-prop)
[92.095887] Starting subtest: invalid-get-prop
[92.100038] Subtest invalid-get-prop: SUCCESS (0.000s)
[92.227277] [079/165] (915s left) kms_addfb_basic (invalid-get-prop-any)
[92.332791] Starting subtest: invalid-get-prop-any
[92.335967] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[92.443538] [080/165] (915s left) kms_addfb_basic (invalid-set-prop)
[92.495063] Starting subtest: invalid-set-prop
[92.498105] Subtest invalid-set-prop: SUCCESS (0.000s)
[92.632778] [081/165] (915s left) kms_addfb_basic (invalid-set-prop-any)
[92.683345] Starting subtest: invalid-set-prop-any
[92.686517] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[92.792053] [082/165] (914s left) kms_addfb_basic (no-handle)
[92.857428] Starting subtest: no-handle
[92.860830] Subtest no-handle: SUCCESS (0.000s)
[92.977126] [083/165] (914s left) kms_addfb_basic (size-max)
[93.073470] Starting subtest: size-max
[93.076493] Subtest size-max: SUCCESS (0.000s)
[93.145597] [084/165] (914s left) kms_addfb_basic (small-bo)
[93.267536] Starting subtest: small-bo
[93.270850] Subtest small-bo: SUCCESS (0.000s)
[93.361625] [085/165] (914s left) kms_addfb_basic (tile-pitch-mismatch)
[93.462352] Starting subtest: tile-pitch-mismatch
[93.465861] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[93.582478] [086/165] (914s left) kms_addfb_basic (too-high)
[93.688687] Starting subtest: too-high
[93.691663] Subtest too-high: SUCCESS (0.000s)
[93.766244] [087/165] (914s left) kms_addfb_basic (too-wide)
[93.896913] Starting subtest: too-wide
[93.899968] Subtest too-wide: SUCCESS (0.000s)
[93.988317] [088/165] (913s left) kms_addfb_basic (unused-handle)
[94.044299] Starting subtest: unused-handle
[94.047456] Subtest unused-handle: SUCCESS (0.000s)
[94.184226] [089/165] (913s left) kms_addfb_basic (unused-modifier)
[94.263883] Starting subtest: unused-modifier
[94.266960] Subtest unused-modifier: SUCCESS (0.000s)
[94.398780] [090/165] (913s left) kms_addfb_basic (unused-offsets)
[94.481275] Starting subtest: unused-offsets
[94.484401] Subtest unused-offsets: SUCCESS (0.000s)
[94.594189] [091/165] (913s left) kms_addfb_basic (unused-pitches)
[94.646667] Starting subtest: unused-pitches
[94.649687] Subtest unused-pitches: SUCCESS (0.000s)
[94.760802] [092/165] (913s left) kms_busy (basic)
[94.863322] Starting subtest: basic
[94.866381] Starting dynamic subtest: flip
[95.576366] Dynamic subtest flip: SUCCESS (0.600s)
[95.641079] Starting dynamic subtest: modeset
[96.162845] Dynamic subtest modeset: SUCCESS (0.584s)
[96.228502] Subtest basic: SUCCESS (1.185s)
[96.459469] [093/165] (911s left) kms_prop_blob (basic)
[96.819234] Starting subtest: basic
[96.822647] Subtest basic: SUCCESS (0.000s)
[96.903751] [094/165] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[97.032131] Starting subtest: basic-busy-flip-before-cursor-atomic
[97.038208] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[97.099028] [095/165] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[97.191220] Starting subtest: basic-busy-flip-before-cursor-legacy
[97.197355] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[97.244520] [096/165] (911s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[97.344783] Starting subtest: basic-flip-after-cursor-atomic
[98.282709] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.937s)
[98.397805] [097/165] (910s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[98.519749] Starting subtest: basic-flip-after-cursor-legacy
[99.482562] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.962s)
[99.615382] [098/165] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[99.712396] Starting subtest: basic-flip-after-cursor-varying-size
[100.650522] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.937s)
[100.794548] [099/165] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[100.929177] Starting subtest: basic-flip-before-cursor-atomic
[101.896471] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.969s)
[102.040417] [100/165] (906s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[102.132791] Starting subtest: basic-flip-before-cursor-legacy
[103.088385] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.956s)
[103.214637] [101/165] (905s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[103.306455] Starting subtest: basic-flip-before-cursor-varying-size
[104.251594] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.944s)
[104.385279] [102/165] (904s left) kms_dsc (dsc-basic)
[104.486181] Subtest dsc-basic: SKIP (0.000s)
[104.509243] [103/165] (904s left) kms_flip (basic-flip-vs-dpms)
[104.592242] Starting subtest: basic-flip-vs-dpms
[104.595442] Starting dynamic subtest: A-HDMI-A1
[105.507301] Dynamic subtest A-HDMI-A1: SUCCESS (0.914s)
[105.515352] Starting dynamic subtest: B-HDMI-A1
[106.335128] Dynamic subtest B-HDMI-A1: SUCCESS (0.831s)
[106.344960] Starting dynamic subtest: C-HDMI-A1
[107.190547] Dynamic subtest C-HDMI-A1: SUCCESS (0.851s)
[107.194007] Subtest basic-flip-vs-dpms: SUCCESS (2.602s)
[107.362936] [104/165] (901s left) kms_flip (basic-flip-vs-modeset)
[107.474515] Starting subtest: basic-flip-vs-modeset
[107.477538] Starting dynamic subtest: A-HDMI-A1
[108.377605] Dynamic subtest A-HDMI-A1: SUCCESS (0.903s)
[108.386874] Starting dynamic subtest: B-HDMI-A1
[109.205336] Dynamic subtest B-HDMI-A1: SUCCESS (0.827s)
[109.214747] Starting dynamic subtest: C-HDMI-A1
[110.061238] Dynamic subtest C-HDMI-A1: SUCCESS (0.846s)
[110.065603] Subtest basic-flip-vs-modeset: SUCCESS (2.589s)
[110.193722] [105/165] (898s left) kms_flip (basic-flip-vs-wf_vblank)
[110.305407] Starting subtest: basic-flip-vs-wf_vblank
[110.308285] Starting dynamic subtest: A-HDMI-A1
[111.556951] Dynamic subtest A-HDMI-A1: SUCCESS (1.157s)
[111.622761] Starting dynamic subtest: B-HDMI-A1
[112.598728] Dynamic subtest B-HDMI-A1: SUCCESS (1.136s)
[112.606930] Starting dynamic subtest: C-HDMI-A1
[113.721650] Dynamic subtest C-HDMI-A1: SUCCESS (1.122s)
[113.724741] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.422s)
[113.923498] [106/165] (894s left) kms_flip (basic-plain-flip)
[114.005965] Starting subtest: basic-plain-flip
[114.008782] Starting dynamic subtest: A-HDMI-A1
[114.869351] Dynamic subtest A-HDMI-A1: SUCCESS (0.859s)
[114.877471] Starting dynamic subtest: B-HDMI-A1
[115.709453] Dynamic subtest B-HDMI-A1: SUCCESS (0.839s)
[115.717589] Starting dynamic subtest: C-HDMI-A1
[116.548094] Dynamic subtest C-HDMI-A1: SUCCESS (0.843s)
[116.551192] Subtest basic-plain-flip: SUCCESS (2.547s)
[116.752889] [107/165] (891s left) kms_force_connector_basic (force-connector-state)
[116.895463] Starting subtest: force-connector-state
[117.169332] Subtest force-connector-state: SUCCESS (0.274s)
[117.576934] [108/165] (891s left) kms_force_connector_basic (force-edid)
[117.737858] Starting subtest: force-edid
[117.878528] Subtest force-edid: SUCCESS (0.141s)
[118.085662] [109/165] (890s left) kms_force_connector_basic (force-load-detect)
[118.261251] Starting subtest: force-load-detect
[118.267793] Subtest force-load-detect: SKIP (0.000s)
[118.457654] [110/165] (890s left) kms_force_connector_basic (prune-stale-modes)
[118.622586] Starting subtest: prune-stale-modes
[118.757657] Subtest prune-stale-modes: SUCCESS (0.135s)
[118.958375] [111/165] (889s left) kms_frontbuffer_tracking (basic)
[119.090394] Starting subtest: basic
[121.440098] Subtest basic: SUCCESS (2.358s)
[121.571159] [112/165] (887s left) kms_hdmi_inject (inject-audio)
[121.679537] Starting subtest: inject-audio
[121.791435] Subtest inject-audio: SUCCESS (0.111s)
[122.019933] [113/165] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[122.129011] Starting subtest: compare-crc-sanitycheck-xr24
[122.131745] Starting dynamic subtest: pipe-A-HDMI-A-1
[122.514326] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.381s)
[122.522375] Starting dynamic subtest: pipe-B-HDMI-A-1
[122.878358] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.364s)
[122.886309] Starting dynamic subtest: pipe-C-HDMI-A-1
[123.241931] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.364s)
[123.245239] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.112s)
[123.375748] [114/165] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[123.490871] Starting subtest: compare-crc-sanitycheck-nv12
[123.494032] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.909343] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.417s)
[123.917311] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.302347] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.392s)
[124.310450] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.317623] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[124.321380] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.812s)
[124.445695] [115/165] (884s left) kms_pipe_crc_basic (hang-read-crc)
[124.545036] Starting subtest: hang-read-crc
[124.548104] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.600374] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.960s)
[125.666301] Starting dynamic subtest: pipe-B-HDMI-A-1
[126.523587] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.016s)
[126.531592] Starting dynamic subtest: pipe-C-HDMI-A-1
[127.509252] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.984s)
[127.512404] Subtest hang-read-crc: SUCCESS (2.964s)
[127.611303] [116/165] (881s left) kms_pipe_crc_basic (nonblocking-crc)
[127.745710] Starting subtest: nonblocking-crc
[127.748869] Starting dynamic subtest: pipe-A-HDMI-A-1
[128.295591] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.549s)
[128.303577] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.823532] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.527s)
[128.831559] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.352345] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.528s)
[129.355438] Subtest nonblocking-crc: SUCCESS (1.608s)
[129.455101] [117/165] (879s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[129.547872] Starting subtest: nonblocking-crc-frame-sequence
[129.550970] Starting dynamic subtest: pipe-A-HDMI-A-1
[130.073378] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s)
[130.082868] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.604691] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.529s)
[130.613867] Starting dynamic subtest: pipe-C-HDMI-A-1
[131.107049] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.501s)
[131.110097] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.560s)
[131.219904] [118/165] (877s left) kms_pipe_crc_basic (read-crc)
[131.325396] Starting subtest: read-crc
[131.328496] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.805094] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.481s)
[131.813195] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.263415] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.458s)
[132.271359] Starting dynamic subtest: pipe-C-HDMI-A-1
[132.723465] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.459s)
[132.726535] Subtest read-crc: SUCCESS (1.401s)
[132.829935] [119/165] (876s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[132.927941] Starting subtest: read-crc-frame-sequence
[132.931154] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.410507] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.481s)
[133.419559] Starting dynamic subtest: pipe-B-HDMI-A-1
[133.894548] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.482s)
[133.902816] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.357564] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.462s)
[134.360680] Subtest read-crc-frame-sequence: SUCCESS (1.429s)
[134.467749] [120/165] (874s left) kms_pm_backlight (basic-brightness)
[134.606861] Subtest basic-brightness: SKIP (0.000s)
[134.623855] [121/165] (874s left) kms_pm_rpm (basic-pci-d3-state)
[136.071741] Starting subtest: basic-pci-d3-state
[136.372413] Subtest basic-pci-d3-state: SUCCESS (0.299s)
[136.627873] [122/165] (872s left) kms_pm_rpm (basic-rte)
[136.676775] Starting subtest: basic-rte
[138.389246] Subtest basic-rte: SUCCESS (1.710s)
[139.277120] [123/165] (869s left) kms_psr (primary_page_flip)
[139.339094] Subtest primary_page_flip: SKIP (0.000s)
[139.392471] [124/165] (869s left) kms_psr (cursor_plane_move)
[139.471248] Subtest cursor_plane_move: SKIP (0.000s)
[139.489525] [125/165] (869s left) kms_psr (sprite_plane_onoff)
[139.538571] Subtest sprite_plane_onoff: SKIP (0.000s)
[139.581342] [126/165] (869s left) kms_psr (primary_mmap_gtt)
[139.639635] Subtest primary_mmap_gtt: SKIP (0.000s)
[139.657770] [127/165] (869s left) kms_setmode (basic-clone-single-crtc)
[139.719806] Starting subtest: basic-clone-single-crtc
[139.729506] Subtest basic-clone-single-crtc: SKIP (0.000s)
[139.779220] [128/165] (869s left) i915_pm_rps (basic-api)
[139.832555] Starting subtest: basic-api
[139.835923] Subtest basic-api: SUCCESS (0.002s)
[139.895898] [129/165] (869s left) prime_self_import (basic-llseek-bad)
[139.965830] Starting subtest: basic-llseek-bad
[139.972598] Subtest basic-llseek-bad: SUCCESS (0.001s)
[140.056227] [130/165] (869s left) prime_self_import (basic-llseek-size)
[140.110623] Starting subtest: basic-llseek-size
[140.117273] Subtest basic-llseek-size: SUCCESS (0.001s)
[140.180049] [131/165] (869s left) prime_self_import (basic-with_fd_dup)
[140.242955] Starting subtest: basic-with_fd_dup
[140.249896] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[140.322162] [132/165] (869s left) prime_self_import (basic-with_one_bo)
[140.403752] Starting subtest: basic-with_one_bo
[140.410619] Subtest basic-with_one_bo: SUCCESS (0.002s)
[140.477527] [133/165] (868s left) prime_self_import (basic-with_one_bo_two_files)
[140.556434] Starting subtest: basic-with_one_bo_two_files
[140.563025] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[140.663433] [134/165] (868s left) prime_self_import (basic-with_two_bos)
[140.716826] Starting subtest: basic-with_two_bos
[140.723639] Subtest basic-with_two_bos: SUCCESS (0.001s)
[140.854961] [135/165] (868s left) prime_vgem (basic-fence-flip)
[140.940276] Starting subtest: basic-fence-flip
[141.358227] Subtest basic-fence-flip: SUCCESS (0.417s)
[141.467457] [136/165] (868s left) prime_vgem (basic-fence-mmap)
[141.541646] Starting subtest: basic-fence-mmap
[141.561759] Subtest basic-fence-mmap: SUCCESS (0.022s)
[141.705683] [137/165] (867s left) prime_vgem (basic-fence-read)
[141.802992] Starting subtest: basic-fence-read
[141.842283] Subtest basic-fence-read: SUCCESS (0.041s)
[141.972261] [138/165] (867s left) prime_vgem (basic-gtt)
[142.062509] Starting subtest: basic-gtt
[142.069176] Subtest basic-gtt: SUCCESS (0.008s)
[142.203108] [139/165] (867s left) prime_vgem (basic-read)
[142.293539] Starting subtest: basic-read
[142.303877] Subtest basic-read: SUCCESS (0.012s)
[142.416599] [140/165] (867s left) prime_vgem (basic-write)
[142.481974] Starting subtest: basic-write
[142.488918] Subtest basic-write: SUCCESS (0.013s)
[142.592983] [141/165] (867s left) vgem_basic (setversion)
[142.659216] Starting subtest: setversion
[142.665131] Subtest setversion: SUCCESS (0.000s)
[142.714528] [142/165] (867s left) vgem_basic (create)
[142.775526] Starting subtest: create
[142.778408] Subtest create: SUCCESS (0.000s)
[142.829056] [143/165] (866s left) vgem_basic (debugfs)
[142.893593] Starting subtest: debugfs
[142.897048] Subtest debugfs: SUCCESS (0.000s)
[142.943567] [144/165] (866s left) vgem_basic (dmabuf-export)
[143.008961] Starting subtest: dmabuf-export
[143.015253] Subtest dmabuf-export: SUCCESS (0.001s)
[143.123853] [145/165] (866s left) vgem_basic (dmabuf-fence)
[143.226338] Starting subtest: dmabuf-fence
[143.229963] Subtest dmabuf-fence: SUCCESS (0.000s)
[143.297497] [146/165] (866s left) vgem_basic (dmabuf-fence-before)
[143.359338] Starting subtest: dmabuf-fence-before
[143.362212] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[143.409833] [147/165] (866s left) vgem_basic (dmabuf-mmap)
[143.479658] Starting subtest: dmabuf-mmap
[143.483086] Subtest dmabuf-mmap: SUCCESS (0.008s)
[143.525329] [148/165] (866s left) vgem_basic (mmap)
[143.577848] Starting subtest: mmap
[143.581013] Subtest mmap: SUCCESS (0.005s)
[143.629972] [149/165] (866s left) vgem_basic (second-client)
[143.709812] Starting subtest: second-client
[143.742980] Subtest second-client: SUCCESS (0.033s)
[143.820254] [150/165] (866s left) vgem_basic (sysfs)
[143.910030] Starting subtest: sysfs
[143.913633] Subtest sysfs: SUCCESS (0.000s)
[143.961051] [151/165] (866s left) core_hotunplug (unbind-rebind)
[144.106985] Starting subtest: unbind-rebind
[148.078692] Subtest unbind-rebind: SUCCESS (3.972s)
[148.098071] [152/165] (862s left) vgem_basic (unload)
[148.144463] Starting subtest: unload
[177.058577] Subtest unload: SUCCESS (28.913s)
[177.172628] [153/165] (832s left) i915_module_load (reload)
[177.255245] Starting subtest: reload
[179.699255] Subtest reload: SUCCESS (2.446s)
[179.722453] [154/165] (830s left) gem_lmem_swapping (basic)
[179.797577] Subtest basic: SKIP (0.000s)
[179.827566] [155/165] (830s left) gem_lmem_swapping (parallel-random-engines)
[179.897730] Subtest parallel-random-engines: SKIP (0.000s)
[179.931323] [156/165] (830s left) gem_lmem_swapping (random-engines)
[180.008362] Subtest random-engines: SKIP (0.000s)
[180.028227] [157/165] (830s left) gem_lmem_swapping (verify-random)
[180.090778] Subtest verify-random: SKIP (0.000s)
[180.115622] [158/165] (830s left) i915_pm_rpm (module-reload)
[181.840693] Starting subtest: module-reload
[189.091892] Subtest module-reload: SUCCESS (7.251s)
[189.109038] [159/165] (821s left) i915_selftest (live)
[189.184086] Starting subtest: live
[189.187394] Starting dynamic subtest: sanitycheck
[190.378500] Dynamic subtest sanitycheck: SUCCESS (1.195s)
[190.386182] Starting dynamic subtest: uncore
[191.489431] Dynamic subtest uncore: SUCCESS (1.110s)
[191.496528] Starting dynamic subtest: workarounds
[192.779577] Dynamic subtest workarounds: SUCCESS (1.289s)
[192.788968] Starting dynamic subtest: gt_engines
[194.439932] Dynamic subtest gt_engines: SUCCESS (1.610s)
[194.505888] Starting dynamic subtest: gt_timelines
[200.965422] Dynamic subtest gt_timelines: SUCCESS (6.574s)
[200.973021] Starting dynamic subtest: gt_contexts
[202.180610] Dynamic subtest gt_contexts: SUCCESS (1.214s)
[202.188089] Starting dynamic subtest: gt_lrc
[205.585603] Dynamic subtest gt_lrc: SUCCESS (3.404s)
[205.593222] Starting dynamic subtest: gt_mocs
[206.797515] Dynamic subtest gt_mocs: SUCCESS (1.211s)
[206.804988] Starting dynamic subtest: gt_pm
[209.772614] Dynamic subtest gt_pm: SUCCESS (2.974s)
[209.781011] Starting dynamic subtest: gt_heartbeat
[210.940496] Dynamic subtest gt_heartbeat: SUCCESS (1.167s)
[210.948411] Starting dynamic subtest: gt_tlb
[212.876580] Dynamic subtest gt_tlb: SUCCESS (1.935s)
[212.884410] Starting dynamic subtest: requests
[220.191916] Dynamic subtest requests: SUCCESS (7.314s)
[220.199490] Starting dynamic subtest: migrate
[224.423422] Dynamic subtest migrate: SUCCESS (4.231s)
[224.430194] Starting dynamic subtest: active
[225.520486] Dynamic subtest active: SUCCESS (1.096s)
[225.528024] Starting dynamic subtest: objects
[227.153658] Dynamic subtest objects: SUCCESS (1.632s)
[227.161009] Starting dynamic subtest: mman
[231.540503] Dynamic subtest mman: SUCCESS (4.386s)
[231.547834] Starting dynamic subtest: dmabuf
[232.692460] Dynamic subtest dmabuf: SUCCESS (1.151s)
[232.701838] Starting dynamic subtest: vma
[233.887627] Dynamic subtest vma: SUCCESS (1.155s)
[233.953267] Starting dynamic subtest: coherency
[235.485571] Dynamic subtest coherency: SUCCESS (1.636s)
[235.493159] Starting dynamic subtest: gtt
[243.836253] Dynamic subtest gtt: SUCCESS (8.348s)
[243.843666] Starting dynamic subtest: gem
[245.034414] Dynamic subtest gem: SUCCESS (1.199s)
[245.041593] Starting dynamic subtest: evict
[246.924577] Dynamic subtest evict: SUCCESS (1.889s)
[246.932075] Starting dynamic subtest: hugepages
[253.988429] Dynamic subtest hugepages: SUCCESS (7.063s)
[253.996238] Starting dynamic subtest: gem_contexts
[266.535441] Dynamic subtest gem_contexts: SUCCESS (12.545s)
[266.544277] Starting dynamic subtest: client
[267.688762] Dynamic subtest client: SUCCESS (1.153s)
[267.696831] Starting dynamic subtest: gem_migrate
[268.845646] Dynamic subtest gem_migrate: SUCCESS (1.156s)
[268.853719] Starting dynamic subtest: reset
[270.283455] Dynamic subtest reset: SUCCESS (1.437s)
[270.291372] Starting dynamic subtest: memory_region
[271.400686] Dynamic subtest memory_region: SUCCESS (1.116s)
[271.408970] Starting dynamic subtest: hangcheck
[295.605630] Dynamic subtest hangcheck: SUCCESS (24.157s)
[295.670066] Starting dynamic subtest: execlists
[304.559769] Dynamic subtest execlists: SUCCESS (9.000s)
[304.567423] Starting dynamic subtest: ring_submission
[305.657675] Dynamic subtest ring_submission: SUCCESS (1.097s)
[305.665670] Starting dynamic subtest: perf
[306.873632] Dynamic subtest perf: SUCCESS (1.215s)
[306.881510] Starting dynamic subtest: slpc
[307.993526] Dynamic subtest slpc: SUCCESS (1.119s)
[308.001707] Starting dynamic subtest: guc
[309.071657] Dynamic subtest guc: SUCCESS (1.077s)
[309.081932] Starting dynamic subtest: guc_multi_lrc
[310.205602] Dynamic subtest guc_multi_lrc: SUCCESS (1.133s)
[310.213457] Starting dynamic subtest: guc_hang
[311.365570] Dynamic subtest guc_hang: SUCCESS (1.159s)
[311.373718] Starting dynamic subtest: late_gt_pm
[312.533429] Dynamic subtest late_gt_pm: SUCCESS (1.167s)
[312.536864] Subtest live: SUCCESS (123.350s)
[312.559902] [160/165] (697s left) dmabuf (all-tests)
[312.641357] Starting subtest: all-tests
[312.648785] Starting dynamic subtest: sanitycheck
[312.722780] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[312.746514] Starting dynamic subtest: dma_fence
[312.912346] Dynamic subtest dma_fence: SUCCESS (0.187s)
[312.923823] Starting dynamic subtest: dma_fence_chain
[323.256347] Dynamic subtest dma_fence_chain: SUCCESS (10.343s)
[323.263252] Starting dynamic subtest: dma_fence_unwrap
[323.331743] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s)
[323.342324] Starting dynamic subtest: dma_resv
[323.412787] Dynamic subtest dma_resv: SUCCESS (0.078s)
[323.417291] Subtest all-tests: SUCCESS (10.773s)
[323.457690] [161/165] (686s left) i915_suspend (basic-s2idle-without-i915)
[323.505410] Starting subtest: basic-s2idle-without-i915
[341.158946] Subtest basic-s2idle-without-i915: SUCCESS (3.244s)
[346.301620] [162/165] (683s left) i915_suspend (basic-s3-without-i915)
[346.352709] Starting subtest: basic-s3-without-i915
[365.490729] Subtest basic-s3-without-i915: SUCCESS (2.583s)
[372.592507] [163/165] (680s left) gem_exec_suspend (basic-s0)
[372.653115] Starting subtest: basic-S0
[372.656378] Starting dynamic subtest: smem
[389.647293] Dynamic subtest smem: SUCCESS (1.689s)
[389.650876] Subtest basic-S0: SUCCESS (1.690s)
[394.813722] [164/165] (678s left) gem_exec_suspend (basic-s3)
[394.869708] Starting subtest: basic-S3
[394.873152] Starting dynamic subtest: smem
[412.851075] Dynamic subtest smem: SUCCESS (1.912s)
[412.854575] Subtest basic-S3: SUCCESS (1.913s)
[422.005221] [165/165] (676s left) kms_pipe_crc_basic (suspend-read-crc)
[422.106187] Starting subtest: suspend-read-crc
[422.109072] Starting dynamic subtest: pipe-A-HDMI-A-1
[440.938067] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.861s)
[440.950358] Starting dynamic subtest: pipe-B-HDMI-A-1
[458.991965] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.969s)
[459.002312] Starting dynamic subtest: pipe-C-HDMI-A-1
[476.977240] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.851s)
[476.980428] Subtest suspend-read-crc: SUCCESS (5.685s)
[484.048873] Closing watchdogs
Done.