[41.372930] Initializing watchdogs
[41.373298]   /dev/watchdog0
[41.409968] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3185 Intel Geminilake (Gen9) GeminiLake [UHD Graphics 600]
[41.422071] [001/162] (960s left) i915_module_load (load)
[41.538202] Starting subtest: load
[44.544155] Subtest load: SUCCESS (3.001s)
[44.635859] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[44.640188] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[44.647714] [002/162] (957s left) core_auth (basic-auth)
[44.793060] Starting subtest: basic-auth
[44.798399] Subtest basic-auth: SUCCESS (0.002s)
[44.935085] [003/162] (957s left) core_debugfs (read-all-entries)
[45.055128] Starting subtest: read-all-entries
[45.124133] Subtest read-all-entries: SUCCESS (0.082s)
[45.283891] [004/162] (956s left) core_sysfs (read-all-entries)
[45.390338] Starting subtest: read-all-entries
[45.395301] Subtest read-all-entries: SUCCESS (0.007s)
[45.517752] [005/162] (956s left) fbdev (eof)
[45.628164] Starting subtest: eof
[45.629800] Subtest eof: SUCCESS (0.001s)
[45.802726] [006/162] (956s left) fbdev (info)
[45.906164] Starting subtest: info
[45.907944] Subtest info: SUCCESS (0.000s)
[46.033220] [007/162] (956s left) fbdev (nullptr)
[46.143050] Starting subtest: nullptr
[46.145265] Subtest nullptr: SUCCESS (0.000s)
[46.251694] [008/162] (956s left) fbdev (read)
[46.357864] Starting subtest: read
[47.932775] Subtest read: SUCCESS (1.574s)
[48.054552] [009/162] (954s left) fbdev (write)
[48.155950] Starting subtest: write
[48.951626] Subtest write: SUCCESS (0.795s)
[49.066369] [010/162] (953s left) gem_basic (bad-close)
[49.167793] Starting subtest: bad-close
[49.171020] Subtest bad-close: SUCCESS (0.000s)
[49.301969] [011/162] (953s left) gem_basic (create-close)
[49.406112] Starting subtest: create-close
[49.408786] Subtest create-close: SUCCESS (0.000s)
[49.533902] [012/162] (953s left) gem_basic (create-fd-close)
[49.638377] Starting subtest: create-fd-close
[49.640940] Subtest create-fd-close: SUCCESS (0.001s)
[49.773345] [013/162] (953s left) gem_busy (busy@all-engines)
[49.909186] Starting subtest: busy
[49.911111] Starting dynamic subtest: all-engines
[49.988302] Dynamic subtest all-engines: SUCCESS (0.079s)
[49.989456] Subtest busy: SUCCESS (0.080s)
[50.385967] [014/162] (952s left) gem_close_race (basic-process)
[50.526135] Starting subtest: basic-process
[50.600379] Subtest basic-process: SUCCESS (0.078s)
[50.851352] [015/162] (952s left) gem_close_race (basic-threads)
[50.982100] Starting subtest: basic-threads
[52.176230] Subtest basic-threads: SUCCESS (1.194s)
[52.421431] [016/162] (950s left) gem_ctx_create (basic)
[52.548034] Starting subtest: basic
[52.549236] Subtest basic: SUCCESS (0.000s)
[52.787263] [017/162] (950s left) gem_ctx_create (basic-files)
[52.911340] Starting subtest: basic-files
[54.938468] Subtest basic-files: SUCCESS (2.026s)
[55.186169] [018/162] (948s left) gem_ctx_exec (basic)
[55.293073] Starting subtest: basic
[55.301254] Subtest basic: SUCCESS (0.007s)
[55.435155] [019/162] (947s left) gem_exec_basic (basic)
[55.548589] Starting subtest: basic
[55.550963] Starting dynamic subtest: rcs0-smem
[55.553646] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[55.574243] Starting dynamic subtest: bcs0-smem
[55.575492] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[55.591734] Starting dynamic subtest: vcs0-smem
[55.593037] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[55.609229] Starting dynamic subtest: vecs0-smem
[55.610752] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[55.612208] Subtest basic: SUCCESS (0.012s)
[55.820810] [020/162] (947s left) gem_exec_create (basic)
[55.947032] Starting subtest: basic
[55.950751] Starting dynamic subtest: smem
[57.994054] Dynamic subtest smem: SUCCESS (2.046s)
[57.996093] Subtest basic: SUCCESS (2.047s)
[58.237195] [021/162] (945s left) gem_exec_fence (basic-busy)
[58.500089] Starting subtest: basic-busy
[58.502359] Starting dynamic subtest: rcs0
[58.515284] Dynamic subtest rcs0: SUCCESS (0.018s)
[58.535119] Starting dynamic subtest: bcs0
[58.548185] Dynamic subtest bcs0: SUCCESS (0.031s)
[58.571372] Starting dynamic subtest: vcs0
[58.579257] Dynamic subtest vcs0: SUCCESS (0.027s)
[58.595958] Starting dynamic subtest: vecs0
[58.600360] Dynamic subtest vecs0: SUCCESS (0.024s)
[58.601648] Subtest basic-busy: SUCCESS (0.104s)
[59.358938] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[59.364780] [022/162] (944s left) gem_exec_fence (basic-wait)
[59.628622] Starting subtest: basic-wait
[59.630061] Starting dynamic subtest: rcs0
[59.646256] Dynamic subtest rcs0: SUCCESS (0.020s)
[59.664405] Starting dynamic subtest: bcs0
[59.675736] Dynamic subtest bcs0: SUCCESS (0.024s)
[59.694060] Starting dynamic subtest: vcs0
[59.695314] Dynamic subtest vcs0: SUCCESS (0.020s)
[59.713295] Starting dynamic subtest: vecs0
[59.715925] Dynamic subtest vecs0: SUCCESS (0.020s)
[59.717087] Subtest basic-wait: SUCCESS (0.091s)
[60.397773] [023/162] (943s left) gem_exec_fence (basic-await)
[60.656286] Starting subtest: basic-await
[60.659173] Starting dynamic subtest: rcs0
[60.779862] Dynamic subtest rcs0: SUCCESS (0.121s)
[60.796943] Starting dynamic subtest: bcs0
[60.899298] Dynamic subtest bcs0: SUCCESS (0.116s)
[60.923048] Starting dynamic subtest: vcs0
[61.019035] Dynamic subtest vcs0: SUCCESS (0.119s)
[61.043066] Starting dynamic subtest: vecs0
[61.133395] Dynamic subtest vecs0: SUCCESS (0.116s)
[61.134597] Subtest basic-await: SUCCESS (0.478s)
[61.846877] [024/162] (942s left) gem_exec_fence (nb-await)
[62.103088] Starting subtest: nb-await
[62.104132] Starting dynamic subtest: rcs0
[62.176335] Dynamic subtest rcs0: SUCCESS (0.072s)
[62.196423] Starting dynamic subtest: bcs0
[62.246258] Dynamic subtest bcs0: SUCCESS (0.067s)
[62.265260] Starting dynamic subtest: vcs0
[62.315088] Dynamic subtest vcs0: SUCCESS (0.067s)
[62.334966] Starting dynamic subtest: vecs0
[62.382535] Dynamic subtest vecs0: SUCCESS (0.067s)
[62.384080] Subtest nb-await: SUCCESS (0.281s)
[63.065901] [025/162] (940s left) gem_exec_gttfill (basic)
[63.203854] Starting subtest: basic
[74.174420] Subtest basic: SUCCESS (10.975s)
[74.438370] [026/162] (929s left) gem_exec_parallel (engines)
[74.719352] Starting subtest: engines
[74.720652] Starting dynamic subtest: basic
[78.113131] Dynamic subtest basic: SUCCESS (3.393s)
[78.134162] Starting dynamic subtest: contexts
[82.521178] Dynamic subtest contexts: SUCCESS (4.407s)
[82.540985] Starting dynamic subtest: fds
[94.570607] Dynamic subtest fds: SUCCESS (12.048s)
[94.592262] Starting dynamic subtest: userptr
[97.970987] Dynamic subtest userptr: SUCCESS (3.399s)
[97.972744] Subtest engines: SUCCESS (23.251s)
[98.229716] [027/162] (905s left) gem_exec_store (basic)
[98.362086] Starting subtest: basic
[98.418698] Subtest basic: SUCCESS (0.057s)
[98.681285] [028/162] (905s left) gem_flink_basic (bad-flink)
[98.785696] Starting subtest: bad-flink
[98.786950] Subtest bad-flink: SUCCESS (0.000s)
[98.932252] [029/162] (905s left) gem_flink_basic (bad-open)
[99.038286] Starting subtest: bad-open
[99.040406] Subtest bad-open: SUCCESS (0.000s)
[99.182370] [030/162] (905s left) gem_flink_basic (basic)
[99.282234] Starting subtest: basic
[99.283393] Subtest basic: SUCCESS (0.000s)
[99.430741] [031/162] (905s left) gem_flink_basic (double-flink)
[99.532161] Starting subtest: double-flink
[99.533376] Subtest double-flink: SUCCESS (0.000s)
[99.680923] [032/162] (904s left) gem_flink_basic (flink-lifetime)
[99.784237] Starting subtest: flink-lifetime
[99.787328] Subtest flink-lifetime: SUCCESS (0.005s)
[99.949369] [033/162] (904s left) gem_huc_copy (huc-copy)
[100.061578] Starting subtest: huc-copy
[100.063761] Subtest huc-copy: SKIP (0.000s)
[100.198684] [034/162] (904s left) gem_linear_blits (basic)
[100.463741] Starting subtest: basic
[100.469205] Subtest basic: SUCCESS (0.012s)
[100.640136] [035/162] (904s left) gem_mmap (basic)
[100.902552] Starting subtest: basic
[100.909967] Subtest basic: SUCCESS (0.001s)
[101.083224] [036/162] (903s left) gem_mmap_gtt (basic)
[101.188284] Starting subtest: basic
[101.190280] Subtest basic: SUCCESS (0.003s)
[101.355069] [037/162] (903s left) gem_render_linear_blits (basic)
[101.467610] Starting subtest: basic
[101.539219] Subtest basic: SUCCESS (0.067s)
[101.655157] [038/162] (903s left) gem_render_tiled_blits (basic)
[101.766298] Starting subtest: basic
[101.873551] Subtest basic: SUCCESS (0.105s)
[101.988914] [039/162] (903s left) gem_ringfill (basic-all)
[102.369265] Starting subtest: basic-all
[103.566507] Subtest basic-all: SUCCESS (1.199s)
[103.733500] [040/162] (901s left) gem_softpin (allocator-basic)
[103.846824] Starting subtest: allocator-basic
[104.084055] Subtest allocator-basic: SUCCESS (0.232s)
[104.252064] [041/162] (901s left) gem_softpin (allocator-basic-reserve)
[104.368325] Starting subtest: allocator-basic-reserve
[104.615732] Subtest allocator-basic-reserve: SUCCESS (0.234s)
[104.782037] [042/162] (900s left) gem_softpin (safe-alignment)
[104.902288] Starting subtest: safe-alignment
[104.928899] Subtest safe-alignment: SUCCESS (0.031s)
[105.086537] [043/162] (900s left) gem_sync (basic-all)
[105.221126] Starting subtest: basic-all
[107.700044] Subtest basic-all: SUCCESS (2.482s)
[107.950773] [044/162] (897s left) gem_sync (basic-each)
[108.084962] Starting subtest: basic-each
[110.369244] Subtest basic-each: SUCCESS (2.287s)
[110.618031] [045/162] (895s left) gem_tiled_blits (basic)
[110.829183] Starting subtest: basic
[110.867244] Subtest basic: SUCCESS (0.040s)
[111.052704] [046/162] (894s left) gem_tiled_fence_blits (basic)
[111.426251] Starting subtest: basic
[111.458110] Subtest basic: SUCCESS (0.033s)
[111.636611] [047/162] (894s left) gem_tiled_pread_basic (basic)
[111.895281] Starting subtest: basic
[112.233156] Subtest basic: SUCCESS (0.337s)
[112.398493] [048/162] (893s left) gem_wait (busy@all-engines)
[112.537189] Starting subtest: busy
[112.540056] Starting dynamic subtest: all-engines
[113.067699] Dynamic subtest all-engines: SUCCESS (0.529s)
[113.071796] Subtest busy: SUCCESS (0.532s)
[113.350118] [049/162] (892s left) gem_wait (wait@all-engines)
[113.482262] Starting subtest: wait
[113.484129] Starting dynamic subtest: all-engines
[114.520103] Dynamic subtest all-engines: SUCCESS (1.038s)
[114.525749] Subtest wait: SUCCESS (1.040s)
[114.817826] [050/162] (891s left) i915_getparams_basic (basic-eu-total)
[114.921629] Starting subtest: basic-eu-total
[114.924597] Subtest basic-eu-total: SUCCESS (0.000s)
[115.067379] [051/162] (891s left) i915_getparams_basic (basic-subslice-total)
[115.166727] Starting subtest: basic-subslice-total
[115.169208] Subtest basic-subslice-total: SUCCESS (0.000s)
[115.300570] [052/162] (891s left) i915_hangman (error-state-basic)
[115.430389] Starting subtest: error-state-basic
[115.454895] Subtest error-state-basic: SUCCESS (0.025s)
[115.634367] [053/162] (891s left) i915_pciid
[115.866847] [054/162] (890s left) intel_hwmon (hwmon-read)
[115.970804] Subtest hwmon-read: SKIP (0.000s)
[116.071832] [055/162] (890s left) intel_hwmon (hwmon-write)
[116.173173] Subtest hwmon-write: SKIP (0.000s)
[116.273193] [056/162] (890s left) kms_addfb_basic (addfb25-4-tiled)
[116.453411] Starting subtest: addfb25-4-tiled
[116.454615] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[116.597850] [057/162] (890s left) kms_addfb_basic (addfb25-bad-modifier)
[116.764763] Starting subtest: addfb25-bad-modifier
[116.765959] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[116.915953] [058/162] (890s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[117.080173] Starting subtest: addfb25-framebuffer-vs-set-tiling
[117.082627] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[117.215890] [059/162] (890s left) kms_addfb_basic (addfb25-modifier-no-flag)
[117.394752] Starting subtest: addfb25-modifier-no-flag
[117.397646] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[117.549807] [060/162] (889s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[117.706459] Starting subtest: addfb25-x-tiled-legacy
[117.708161] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[117.848976] [061/162] (889s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[118.018185] Starting subtest: addfb25-x-tiled-mismatch-legacy
[118.020172] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[118.167549] [062/162] (889s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[118.338567] Starting subtest: addfb25-yf-tiled-legacy
[118.339860] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[118.499969] [063/162] (889s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[118.671504] Starting subtest: addfb25-y-tiled-legacy
[118.672720] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[118.818358] [064/162] (888s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[118.984114] Starting subtest: addfb25-y-tiled-small-legacy
[118.986070] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[119.132326] [065/162] (888s left) kms_addfb_basic (bad-pitch-0)
[119.235274] Starting subtest: bad-pitch-0
[119.236521] Subtest bad-pitch-0: SUCCESS (0.000s)
[119.448841] [066/162] (888s left) kms_addfb_basic (bad-pitch-1024)
[119.552189] Starting subtest: bad-pitch-1024
[119.555088] Subtest bad-pitch-1024: SUCCESS (0.000s)
[119.766350] [067/162] (888s left) kms_addfb_basic (bad-pitch-128)
[119.868503] Starting subtest: bad-pitch-128
[119.870143] Subtest bad-pitch-128: SUCCESS (0.000s)
[120.098713] [068/162] (888s left) kms_addfb_basic (bad-pitch-256)
[120.203204] Starting subtest: bad-pitch-256
[120.207209] Subtest bad-pitch-256: SUCCESS (0.000s)
[120.415465] [069/162] (887s left) kms_addfb_basic (bad-pitch-32)
[120.520233] Starting subtest: bad-pitch-32
[120.521850] Subtest bad-pitch-32: SUCCESS (0.000s)
[120.750994] [070/162] (887s left) kms_addfb_basic (bad-pitch-63)
[120.857111] Starting subtest: bad-pitch-63
[120.858813] Subtest bad-pitch-63: SUCCESS (0.000s)
[121.066536] [071/162] (887s left) kms_addfb_basic (bad-pitch-65536)
[121.168061] Starting subtest: bad-pitch-65536
[121.170053] Subtest bad-pitch-65536: SUCCESS (0.001s)
[121.383227] [072/162] (887s left) kms_addfb_basic (bad-pitch-999)
[121.485351] Starting subtest: bad-pitch-999
[121.486814] Subtest bad-pitch-999: SUCCESS (0.000s)
[121.699911] [073/162] (886s left) kms_addfb_basic (basic)
[121.801232] Starting subtest: basic
[121.805256] Subtest basic: SUCCESS (0.000s)
[122.016230] [074/162] (886s left) kms_addfb_basic (basic-x-tiled-legacy)
[122.121764] Starting subtest: basic-x-tiled-legacy
[122.124060] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[122.331971] [075/162] (886s left) kms_addfb_basic (basic-y-tiled-legacy)
[122.435314] Starting subtest: basic-y-tiled-legacy
[122.436461] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[122.647321] [076/162] (886s left) kms_addfb_basic (bo-too-small)
[122.805030] Starting subtest: bo-too-small
[122.808356] Subtest bo-too-small: SUCCESS (0.001s)
[122.948895] [077/162] (886s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[123.120347] Starting subtest: bo-too-small-due-to-tiling
[123.121641] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[123.264593] [078/162] (885s left) kms_addfb_basic (clobberred-modifier)
[123.367190] Starting subtest: clobberred-modifier
[123.370080] Subtest clobberred-modifier: SUCCESS (0.000s)
[123.566515] [079/162] (885s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[123.671082] Starting subtest: framebuffer-vs-set-tiling
[123.673064] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[123.901342] [080/162] (885s left) kms_addfb_basic (invalid-get-prop)
[124.005131] Starting subtest: invalid-get-prop
[124.007170] Subtest invalid-get-prop: SUCCESS (0.000s)
[124.214609] [081/162] (885s left) kms_addfb_basic (invalid-get-prop-any)
[124.317760] Starting subtest: invalid-get-prop-any
[124.319142] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[124.532886] [082/162] (884s left) kms_addfb_basic (invalid-set-prop)
[124.637134] Starting subtest: invalid-set-prop
[124.639070] Subtest invalid-set-prop: SUCCESS (0.000s)
[124.832423] [083/162] (884s left) kms_addfb_basic (invalid-set-prop-any)
[124.936079] Starting subtest: invalid-set-prop-any
[124.938163] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[125.132234] [084/162] (884s left) kms_addfb_basic (no-handle)
[125.234384] Starting subtest: no-handle
[125.235522] Subtest no-handle: SUCCESS (0.000s)
[125.448306] [085/162] (884s left) kms_addfb_basic (size-max)
[125.611541] Starting subtest: size-max
[125.613511] Subtest size-max: SUCCESS (0.000s)
[125.752072] [086/162] (884s left) kms_addfb_basic (small-bo)
[125.917356] Starting subtest: small-bo
[125.918454] Subtest small-bo: SUCCESS (0.000s)
[126.066158] [087/162] (883s left) kms_addfb_basic (tile-pitch-mismatch)
[126.175192] Starting subtest: tile-pitch-mismatch
[126.176924] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[126.397814] [088/162] (883s left) kms_addfb_basic (too-high)
[126.564188] Starting subtest: too-high
[126.566168] Subtest too-high: SUCCESS (0.002s)
[126.716312] [089/162] (883s left) kms_addfb_basic (too-wide)
[126.888300] Starting subtest: too-wide
[126.889319] Subtest too-wide: SUCCESS (0.000s)
[127.031882] [090/162] (883s left) kms_addfb_basic (unused-handle)
[127.136217] Starting subtest: unused-handle
[127.138109] Subtest unused-handle: SUCCESS (0.000s)
[127.347914] [091/162] (882s left) kms_addfb_basic (unused-modifier)
[127.448968] Starting subtest: unused-modifier
[127.452079] Subtest unused-modifier: SUCCESS (0.000s)
[127.647640] [092/162] (882s left) kms_addfb_basic (unused-offsets)
[127.749145] Starting subtest: unused-offsets
[127.752091] Subtest unused-offsets: SUCCESS (0.000s)
[127.949951] [093/162] (882s left) kms_addfb_basic (unused-pitches)
[128.049242] Starting subtest: unused-pitches
[128.053075] Subtest unused-pitches: SUCCESS (0.000s)
[128.266847] [094/162] (882s left) kms_busy (basic)
[128.433101] Starting subtest: basic
[128.446097] Starting dynamic subtest: flip
[129.232122] Dynamic subtest flip: SUCCESS (0.788s)
[129.267914] Starting dynamic subtest: modeset
[130.617287] Dynamic subtest modeset: SUCCESS (1.385s)
[130.619930] Subtest basic: SUCCESS (2.177s)
[130.923989] [095/162] (879s left) kms_prop_blob (basic)
[131.031148] Starting subtest: basic
[131.033385] Subtest basic: SUCCESS (0.000s)
[131.171876] [096/162] (879s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[131.340723] Starting subtest: basic-busy-flip-before-cursor-atomic
[131.345166] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.001s)
[131.487220] [097/162] (879s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[131.658097] Starting subtest: basic-busy-flip-before-cursor-legacy
[131.664071] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[131.786796] [098/162] (879s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[131.952118] Starting subtest: basic-flip-after-cursor-atomic
[133.096279] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.144s)
[133.339931] [099/162] (877s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[133.519102] Starting subtest: basic-flip-after-cursor-legacy
[134.688065] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.174s)
[134.916960] [100/162] (876s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[135.111135] Starting subtest: basic-flip-after-cursor-varying-size
[136.287551] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.207s)
[136.531785] [101/162] (874s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[136.697817] Starting subtest: basic-flip-before-cursor-atomic
[137.856599] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.156s)
[138.081784] [102/162] (873s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[138.251973] Starting subtest: basic-flip-before-cursor-legacy
[139.412768] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.158s)
[139.636226] [103/162] (871s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[139.798316] Starting subtest: basic-flip-before-cursor-varying-size
[140.998954] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.203s)
[141.230186] [104/162] (870s left) kms_dsc (dsc-basic)
[141.398618] Subtest dsc-basic: SKIP (0.000s)
[141.503578] [105/162] (870s left) kms_flip (basic-flip-vs-dpms)
[141.677153] Starting subtest: basic-flip-vs-dpms
[141.679192] Starting dynamic subtest: A-HDMI-A2
[142.993154] Dynamic subtest A-HDMI-A2: SUCCESS (1.308s)
[143.022613] Starting dynamic subtest: B-HDMI-A2
[143.969338] Dynamic subtest B-HDMI-A2: SUCCESS (0.979s)
[143.994871] Starting dynamic subtest: C-HDMI-A2
[145.050042] Dynamic subtest C-HDMI-A2: SUCCESS (1.070s)
[145.055303] Subtest basic-flip-vs-dpms: SUCCESS (3.370s)
[145.358809] [106/162] (866s left) kms_flip (basic-flip-vs-modeset)
[145.524112] Starting subtest: basic-flip-vs-modeset
[145.535852] Starting dynamic subtest: A-HDMI-A2
[146.896830] Dynamic subtest A-HDMI-A2: SUCCESS (1.366s)
[146.921703] Starting dynamic subtest: B-HDMI-A2
[147.976966] Dynamic subtest B-HDMI-A2: SUCCESS (1.075s)
[148.010149] Starting dynamic subtest: C-HDMI-A2
[149.152156] Dynamic subtest C-HDMI-A2: SUCCESS (1.166s)
[149.153345] Subtest basic-flip-vs-modeset: SUCCESS (3.624s)
[149.457397] [107/162] (862s left) kms_flip (basic-flip-vs-wf_vblank)
[149.638145] Starting subtest: basic-flip-vs-wf_vblank
[149.640239] Starting dynamic subtest: A-HDMI-A2
[151.168104] Dynamic subtest A-HDMI-A2: SUCCESS (1.525s)
[151.189362] Starting dynamic subtest: B-HDMI-A2
[152.528607] Dynamic subtest B-HDMI-A2: SUCCESS (1.357s)
[152.549883] Starting dynamic subtest: C-HDMI-A2
[153.896050] Dynamic subtest C-HDMI-A2: SUCCESS (1.364s)
[153.898125] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.260s)
[154.345103] [108/162] (857s left) kms_flip (basic-plain-flip)
[154.522102] Starting subtest: basic-plain-flip
[154.524134] Starting dynamic subtest: A-HDMI-A2
[155.645626] Dynamic subtest A-HDMI-A2: SUCCESS (1.124s)
[155.667338] Starting dynamic subtest: B-HDMI-A2
[156.723635] Dynamic subtest B-HDMI-A2: SUCCESS (1.074s)
[156.746652] Starting dynamic subtest: C-HDMI-A2
[157.803842] Dynamic subtest C-HDMI-A2: SUCCESS (1.076s)
[157.806229] Subtest basic-plain-flip: SUCCESS (3.287s)
[158.226677] [109/162] (853s left) kms_force_connector_basic (force-connector-state)
[158.417124] Starting subtest: force-connector-state
[158.857132] Subtest force-connector-state: SUCCESS (0.422s)
[159.259280] [110/162] (852s left) kms_force_connector_basic (force-edid)
[159.466109] Starting subtest: force-edid
[159.518143] Subtest force-edid: SUCCESS (0.058s)
[159.808422] [111/162] (852s left) kms_force_connector_basic (force-load-detect)
[159.998474] Starting subtest: force-load-detect
[160.003417] Subtest force-load-detect: SKIP (0.000s)
[160.273562] [112/162] (852s left) kms_force_connector_basic (prune-stale-modes)
[160.490388] Starting subtest: prune-stale-modes
[160.550546] Subtest prune-stale-modes: SUCCESS (0.068s)
[160.890195] [113/162] (851s left) kms_frontbuffer_tracking (basic)
[161.093653] Starting subtest: basic
[164.298233] Subtest basic: SUCCESS (3.204s)
[164.477370] [114/162] (848s left) kms_hdmi_inject (inject-audio)
[164.846818] Starting subtest: inject-audio
[165.141960] Subtest inject-audio: SUCCESS (0.296s)
[165.571642] [115/162] (847s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[165.737105] Starting subtest: compare-crc-sanitycheck-xr24
[165.748080] Starting dynamic subtest: pipe-A-HDMI-A-2
[166.330100] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.578s)
[166.375657] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.920110] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.585s)
[166.953129] Starting dynamic subtest: pipe-C-HDMI-A-2
[167.502333] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.576s)
[167.503739] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.766s)
[167.769651] [116/162] (844s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[167.930095] Starting subtest: compare-crc-sanitycheck-nv12
[167.942121] Starting dynamic subtest: pipe-A-HDMI-A-2
[168.612821] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.674s)
[168.644390] Starting dynamic subtest: pipe-B-HDMI-A-2
[169.319276] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.698s)
[169.346163] Starting dynamic subtest: pipe-C-HDMI-A-2
[170.019367] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.697s)
[170.021379] Subtest compare-crc-sanitycheck-nv12: SUCCESS (2.088s)
[170.296451] [117/162] (842s left) kms_pipe_crc_basic (hang-read-crc)
[170.467025] Starting subtest: hang-read-crc
[170.476978] Starting dynamic subtest: pipe-A-HDMI-A-2
[171.866691] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.394s)
[171.902992] Starting dynamic subtest: pipe-B-HDMI-A-2
[173.243128] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.369s)
[173.274583] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.638912] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.388s)
[174.640873] Subtest hang-read-crc: SUCCESS (4.175s)
[174.884612] [118/162] (838s left) kms_pipe_crc_basic (nonblocking-crc)
[175.056225] Starting subtest: nonblocking-crc
[175.057415] Starting dynamic subtest: pipe-A-HDMI-A-2
[175.808151] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.748s)
[175.857297] Starting dynamic subtest: pipe-B-HDMI-A-2
[176.524154] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.712s)
[176.549800] Starting dynamic subtest: pipe-C-HDMI-A-2
[177.282091] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.748s)
[177.283464] Subtest nonblocking-crc: SUCCESS (2.226s)
[177.539589] [119/162] (835s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[177.706347] Starting subtest: nonblocking-crc-frame-sequence
[177.708071] Starting dynamic subtest: pipe-A-HDMI-A-2
[178.497151] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.786s)
[178.541264] Starting dynamic subtest: pipe-B-HDMI-A-2
[179.237848] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.734s)
[179.269044] Starting dynamic subtest: pipe-C-HDMI-A-2
[180.049128] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.801s)
[180.050838] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.343s)
[180.330880] [120/162] (832s left) kms_pipe_crc_basic (read-crc)
[180.510137] Starting subtest: read-crc
[180.511220] Starting dynamic subtest: pipe-A-HDMI-A-2
[181.210157] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.700s)
[181.248953] Starting dynamic subtest: pipe-B-HDMI-A-2
[181.909986] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.691s)
[181.939404] Starting dynamic subtest: pipe-C-HDMI-A-2
[182.597802] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.677s)
[182.599642] Subtest read-crc: SUCCESS (2.091s)
[182.854442] [121/162] (830s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[183.039555] Starting subtest: read-crc-frame-sequence
[183.045160] Starting dynamic subtest: pipe-A-HDMI-A-2
[183.758266] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.714s)
[183.792804] Starting dynamic subtest: pipe-B-HDMI-A-2
[184.442151] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.678s)
[184.480296] Starting dynamic subtest: pipe-C-HDMI-A-2
[185.127069] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.679s)
[185.133753] Subtest read-crc-frame-sequence: SUCCESS (2.093s)
[185.385660] [122/162] (827s left) kms_pm_backlight (basic-brightness)
[185.563537] Subtest basic-brightness: SKIP (0.000s)
[185.676604] [123/162] (827s left) kms_pm_rpm (basic-pci-d3-state)
[187.363294] Starting subtest: basic-pci-d3-state
[187.734045] Subtest basic-pci-d3-state: SUCCESS (0.365s)
[187.934151] [124/162] (825s left) kms_pm_rpm (basic-rte)
[188.035135] Starting subtest: basic-rte
[189.958076] Subtest basic-rte: SUCCESS (1.921s)
[190.728270] [125/162] (822s left) kms_psr (psr-primary-page-flip)
[190.907170] Subtest psr-primary-page-flip: SKIP (0.000s)
[191.019300] [126/162] (822s left) kms_psr (psr-cursor-plane-move)
[191.204255] Subtest psr-cursor-plane-move: SKIP (0.000s)
[191.318966] [127/162] (822s left) kms_psr (psr-sprite-plane-onoff)
[191.486255] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[191.601943] [128/162] (822s left) kms_psr (psr-primary-mmap-gtt)
[191.786040] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[191.903309] [129/162] (822s left) kms_setmode (basic-clone-single-crtc)
[192.011105] Starting subtest: basic-clone-single-crtc
[192.018112] Subtest basic-clone-single-crtc: SKIP (0.000s)
[192.163194] [130/162] (821s left) i915_pm_rps (basic-api)
[192.287406] Starting subtest: basic-api
[192.296159] Subtest basic-api: SUCCESS (0.011s)
[192.447906] [131/162] (821s left) prime_self_import (basic-llseek-bad)
[192.548089] Starting subtest: basic-llseek-bad
[192.553859] Subtest basic-llseek-bad: SUCCESS (0.008s)
[192.712114] [132/162] (821s left) prime_self_import (basic-llseek-size)
[192.817097] Starting subtest: basic-llseek-size
[192.821348] Subtest basic-llseek-size: SUCCESS (0.007s)
[192.964338] [133/162] (821s left) prime_self_import (basic-with_fd_dup)
[193.070773] Starting subtest: basic-with_fd_dup
[193.075112] Subtest basic-with_fd_dup: SUCCESS (0.008s)
[193.229638] [134/162] (821s left) prime_self_import (basic-with_one_bo)
[193.331248] Starting subtest: basic-with_one_bo
[193.339075] Subtest basic-with_one_bo: SUCCESS (0.006s)
[193.504883] [135/162] (821s left) prime_self_import (basic-with_one_bo_two_files)
[193.607141] Starting subtest: basic-with_one_bo_two_files
[193.613952] Subtest basic-with_one_bo_two_files: SUCCESS (0.008s)
[193.761917] [136/162] (820s left) prime_self_import (basic-with_two_bos)
[193.865573] Starting subtest: basic-with_two_bos
[193.869350] Subtest basic-with_two_bos: SUCCESS (0.007s)
[194.011941] [137/162] (820s left) prime_vgem (basic-fence-flip)
[194.151527] Starting subtest: basic-fence-flip
[194.653049] Subtest basic-fence-flip: SUCCESS (0.498s)
[194.816328] [138/162] (820s left) prime_vgem (basic-fence-mmap)
[194.953295] Starting subtest: basic-fence-mmap
[195.016869] Subtest basic-fence-mmap: SUCCESS (0.063s)
[195.183989] [139/162] (819s left) prime_vgem (basic-fence-read)
[195.317435] Starting subtest: basic-fence-read
[195.452601] Subtest basic-fence-read: SUCCESS (0.133s)
[195.599364] [140/162] (819s left) prime_vgem (basic-gtt)
[195.740127] Starting subtest: basic-gtt
[195.773226] Subtest basic-gtt: SUCCESS (0.036s)
[195.913930] [141/162] (819s left) prime_vgem (basic-read)
[196.056069] Starting subtest: basic-read
[196.121437] Subtest basic-read: SUCCESS (0.069s)
[196.313719] [142/162] (818s left) prime_vgem (basic-write)
[196.437178] Starting subtest: basic-write
[196.524211] Subtest basic-write: SUCCESS (0.087s)
[196.681138] [143/162] (818s left) vgem_basic (setversion)
[196.808390] Starting subtest: setversion
[196.810702] Subtest setversion: SUCCESS (0.000s)
[196.930585] [144/162] (818s left) vgem_basic (create)
[197.040120] Starting subtest: create
[197.041322] Subtest create: SUCCESS (0.001s)
[197.164581] [145/162] (818s left) vgem_basic (debugfs)
[197.272568] Starting subtest: debugfs
[197.275147] Subtest debugfs: SUCCESS (0.001s)
[197.398417] [146/162] (818s left) vgem_basic (dmabuf-export)
[197.528475] Starting subtest: dmabuf-export
[197.532408] Subtest dmabuf-export: SUCCESS (0.005s)
[197.680401] [147/162] (818s left) vgem_basic (dmabuf-fence)
[197.802389] Starting subtest: dmabuf-fence
[197.803595] Subtest dmabuf-fence: SUCCESS (0.001s)
[197.931877] [148/162] (817s left) vgem_basic (dmabuf-fence-before)
[198.060385] Starting subtest: dmabuf-fence-before
[198.061954] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[198.181664] [149/162] (817s left) vgem_basic (dmabuf-mmap)
[198.315115] Starting subtest: dmabuf-mmap
[198.330587] Subtest dmabuf-mmap: SUCCESS (0.028s)
[198.464239] [150/162] (817s left) vgem_basic (mmap)
[198.590899] Starting subtest: mmap
[198.605565] Subtest mmap: SUCCESS (0.019s)
[198.730095] [151/162] (817s left) vgem_basic (second-client)
[198.858766] Starting subtest: second-client
[198.894673] Subtest second-client: SUCCESS (0.032s)
[199.015518] [152/162] (817s left) vgem_basic (sysfs)
[199.144511] Starting subtest: sysfs
[199.145944] Subtest sysfs: SUCCESS (0.001s)
[199.265468] [153/162] (817s left) core_hotunplug (unbind-rebind)
[199.491608] Starting subtest: unbind-rebind
[203.401721] Subtest unbind-rebind: SUCCESS (3.905s)
[203.501531] [154/162] (813s left) vgem_basic (unload)
[203.609799] Starting subtest: unload
[232.551122] Subtest unload: SUCCESS (28.937s)
[232.759239] [155/162] (783s left) i915_module_load (reload)
[232.860134] Starting subtest: reload
[237.009665] Subtest reload: SUCCESS (4.148s)
[237.246517] [156/162] (779s left) gem_lmem_swapping (basic)
[237.382912] Subtest basic: SKIP (0.000s)
[237.491836] [157/162] (779s left) gem_lmem_swapping (parallel-random-engines)
[237.610355] Subtest parallel-random-engines: SKIP (0.000s)
[237.724224] [158/162] (779s left) gem_lmem_swapping (random-engines)
[237.833898] Subtest random-engines: SKIP (0.000s)
[237.941714] [159/162] (779s left) gem_lmem_swapping (verify-random)
[238.055308] Subtest verify-random: SKIP (0.000s)
[238.159198] [160/162] (779s left) i915_pm_rpm (module-reload)
[240.059267] Starting subtest: module-reload
[252.521156] Subtest module-reload: SUCCESS (12.475s)
[252.590240] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[252.593198] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[252.599609] [161/162] (764s left) i915_selftest (live)