[32.093011] Initializing watchdogs
[32.093154]   /dev/watchdog0
[32.119123] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640
[32.125430] [001/162] (960s left) i915_module_load (load)
[32.192240] Starting subtest: load
[34.571400] Subtest load: SUCCESS (2.378s)
[34.615786] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[34.617896] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[34.621440] [002/162] (958s left) core_auth (basic-auth)
[34.735830] Starting subtest: basic-auth
[34.737130] Subtest basic-auth: SUCCESS (0.002s)
[34.816428] [003/162] (957s left) core_debugfs (read-all-entries)
[34.875096] Starting subtest: read-all-entries
[34.877153] Subtest read-all-entries: SUCCESS (0.003s)
[34.926818] [004/162] (957s left) core_sysfs (read-all-entries)
[34.986703] Starting subtest: read-all-entries
[34.992993] Subtest read-all-entries: SUCCESS (0.006s)
[35.042930] [005/162] (957s left) fbdev (eof)
[35.112567] Subtest eof: SKIP (0.000s)
[35.159987] [006/162] (957s left) fbdev (info)
[35.228413] Subtest info: SKIP (0.000s)
[35.274801] [007/162] (957s left) fbdev (nullptr)
[35.343176] Subtest nullptr: SKIP (0.000s)
[35.389679] [008/162] (957s left) fbdev (read)
[35.459064] Subtest read: SKIP (0.000s)
[35.505846] [009/162] (957s left) fbdev (write)
[35.574496] Subtest write: SKIP (0.000s)
[35.620509] [010/162] (957s left) gem_basic (bad-close)
[35.676993] Starting subtest: bad-close
[35.678925] Subtest bad-close: SUCCESS (0.000s)
[35.725513] [011/162] (957s left) gem_basic (create-close)
[35.781536] Starting subtest: create-close
[35.783401] Subtest create-close: SUCCESS (0.000s)
[35.848100] [012/162] (957s left) gem_basic (create-fd-close)
[35.905340] Starting subtest: create-fd-close
[35.908288] Subtest create-fd-close: SUCCESS (0.000s)
[35.978419] [013/162] (957s left) gem_busy (busy@all-engines)
[36.057718] Starting subtest: busy
[36.058821] Starting dynamic subtest: all-engines
[36.127741] Dynamic subtest all-engines: SUCCESS (0.070s)
[36.129099] Subtest busy: SUCCESS (0.070s)
[36.526870] [014/162] (956s left) gem_close_race (basic-process)
[36.611907] Starting subtest: basic-process
[36.679020] Subtest basic-process: SUCCESS (0.068s)
[36.922113] [015/162] (956s left) gem_close_race (basic-threads)
[37.004730] Starting subtest: basic-threads
[38.224035] Subtest basic-threads: SUCCESS (1.193s)
[38.407627] [016/162] (955s left) gem_ctx_create (basic)
[38.492481] Starting subtest: basic
[38.493702] Subtest basic: SUCCESS (0.000s)
[38.678784] [017/162] (954s left) gem_ctx_create (basic-files)
[38.761760] Starting subtest: basic-files
[40.780652] Subtest basic-files: SUCCESS (2.018s)
[41.033916] [018/162] (952s left) gem_ctx_exec (basic)
[41.100660] Starting subtest: basic
[41.106902] Subtest basic: SUCCESS (0.006s)
[41.180206] [019/162] (952s left) gem_exec_basic (basic)
[41.249577] Starting subtest: basic
[41.250687] Starting dynamic subtest: rcs0-smem
[41.253591] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[41.263646] Starting dynamic subtest: bcs0-smem
[41.264855] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[41.274317] Starting dynamic subtest: vcs0-smem
[41.275598] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[41.284990] Starting dynamic subtest: vcs1-smem
[41.286239] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[41.295563] Starting dynamic subtest: vecs0-smem
[41.296819] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[41.298027] Subtest basic: SUCCESS (0.011s)
[41.466446] [020/162] (952s left) gem_exec_create (basic)
[41.615541] Starting subtest: basic
[41.616594] Starting dynamic subtest: smem
[43.635177] Dynamic subtest smem: SUCCESS (2.054s)
[43.636602] Subtest basic: SUCCESS (2.055s)
[43.784555] [021/162] (950s left) gem_exec_fence (basic-busy)
[44.010529] Starting subtest: basic-busy
[44.012160] Starting dynamic subtest: rcs0
[44.046559] Dynamic subtest rcs0: SUCCESS (0.036s)
[44.059524] Starting dynamic subtest: bcs0
[44.079563] Dynamic subtest bcs0: SUCCESS (0.032s)
[44.093822] Starting dynamic subtest: vcs0
[44.099472] Dynamic subtest vcs0: SUCCESS (0.020s)
[44.112583] Starting dynamic subtest: vcs1
[44.122744] Dynamic subtest vcs1: SUCCESS (0.023s)
[44.135285] Starting dynamic subtest: vecs0
[44.147302] Dynamic subtest vecs0: SUCCESS (0.023s)
[44.148530] Subtest basic-busy: SUCCESS (0.137s)
[44.835780] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[44.838351] [022/162] (949s left) gem_exec_fence (basic-wait)
[45.064854] Starting subtest: basic-wait
[45.066042] Starting dynamic subtest: rcs0
[45.096371] Dynamic subtest rcs0: SUCCESS (0.033s)
[45.107218] Starting dynamic subtest: bcs0
[45.118460] Dynamic subtest bcs0: SUCCESS (0.022s)
[45.129470] Starting dynamic subtest: vcs0
[45.139432] Dynamic subtest vcs0: SUCCESS (0.021s)
[45.149944] Starting dynamic subtest: vcs1
[45.163418] Dynamic subtest vcs1: SUCCESS (0.023s)
[45.174275] Starting dynamic subtest: vecs0
[45.193517] Dynamic subtest vecs0: SUCCESS (0.031s)
[45.194629] Subtest basic-wait: SUCCESS (0.130s)
[45.868841] [023/162] (948s left) gem_exec_fence (basic-await)
[46.100518] Starting subtest: basic-await
[46.102455] Starting dynamic subtest: rcs0
[46.274303] Dynamic subtest rcs0: SUCCESS (0.114s)
[46.285506] Starting dynamic subtest: bcs0
[46.321638] Dynamic subtest bcs0: SUCCESS (0.107s)
[46.336810] Starting dynamic subtest: vcs0
[46.433871] Dynamic subtest vcs0: SUCCESS (0.112s)
[46.450094] Starting dynamic subtest: vcs1
[46.549777] Dynamic subtest vcs1: SUCCESS (0.115s)
[46.565597] Starting dynamic subtest: vecs0
[46.666146] Dynamic subtest vecs0: SUCCESS (0.116s)
[46.668317] Subtest basic-await: SUCCESS (0.567s)
[47.344826] [024/162] (946s left) gem_exec_fence (nb-await)
[47.570280] Starting subtest: nb-await
[47.571515] Starting dynamic subtest: rcs0
[47.639593] Dynamic subtest rcs0: SUCCESS (0.069s)
[47.661260] Starting dynamic subtest: bcs0
[47.718775] Dynamic subtest bcs0: SUCCESS (0.077s)
[47.750546] Starting dynamic subtest: vcs0
[47.806569] Dynamic subtest vcs0: SUCCESS (0.087s)
[47.837428] Starting dynamic subtest: vcs1
[47.892113] Dynamic subtest vcs1: SUCCESS (0.082s)
[47.922262] Starting dynamic subtest: vecs0
[47.973673] Dynamic subtest vecs0: SUCCESS (0.082s)
[47.975835] Subtest nb-await: SUCCESS (0.404s)
[48.643062] [025/162] (945s left) gem_exec_gttfill (basic)
[48.729124] Starting subtest: basic
[53.561769] Subtest basic: SUCCESS (4.738s)
[53.824504] [026/162] (940s left) gem_exec_parallel (engines)
[54.060025] Starting subtest: engines
[54.061103] Starting dynamic subtest: basic
[56.538545] Dynamic subtest basic: SUCCESS (2.475s)
[56.554374] Starting dynamic subtest: contexts
[60.982925] Dynamic subtest contexts: SUCCESS (4.457s)
[60.995325] Starting dynamic subtest: fds
[66.212689] Dynamic subtest fds: SUCCESS (5.185s)
[66.224165] Starting dynamic subtest: userptr
[69.174162] Dynamic subtest userptr: SUCCESS (2.937s)
[69.176165] Subtest engines: SUCCESS (15.054s)
[69.367254] [027/162] (924s left) gem_exec_store (basic)
[69.452781] Starting subtest: basic
[69.520177] Subtest basic: SUCCESS (0.067s)
[69.716140] [028/162] (924s left) gem_flink_basic (bad-flink)
[69.774404] Starting subtest: bad-flink
[69.775531] Subtest bad-flink: SUCCESS (0.000s)
[69.829735] [029/162] (924s left) gem_flink_basic (bad-open)
[69.888875] Starting subtest: bad-open
[69.890046] Subtest bad-open: SUCCESS (0.000s)
[69.949420] [030/162] (924s left) gem_flink_basic (basic)
[70.273680] Starting subtest: basic
[70.275935] Subtest basic: SUCCESS (0.000s)
[70.379128] [031/162] (924s left) gem_flink_basic (double-flink)
[70.436437] Starting subtest: double-flink
[70.437320] Subtest double-flink: SUCCESS (0.000s)
[70.515687] [032/162] (924s left) gem_flink_basic (flink-lifetime)
[70.572495] Starting subtest: flink-lifetime
[70.574971] Subtest flink-lifetime: SUCCESS (0.002s)
[70.655266] [033/162] (924s left) gem_huc_copy (huc-copy)
[70.724608] Starting subtest: huc-copy
[70.726835] Subtest huc-copy: SKIP (0.000s)
[70.808812] [034/162] (923s left) gem_linear_blits (basic)
[70.984212] Starting subtest: basic
[70.990910] Subtest basic: SUCCESS (0.007s)
[71.087578] [035/162] (923s left) gem_mmap (basic)
[71.248611] Starting subtest: basic
[71.254203] Subtest basic: SUCCESS (0.001s)
[71.337157] [036/162] (923s left) gem_mmap_gtt (basic)
[71.395897] Starting subtest: basic
[71.396915] Subtest basic: SUCCESS (0.001s)
[71.453961] [037/162] (923s left) gem_render_linear_blits (basic)
[71.523056] Starting subtest: basic
[71.556020] Subtest basic: SUCCESS (0.034s)
[71.626931] [038/162] (923s left) gem_render_tiled_blits (basic)
[71.695795] Starting subtest: basic
[71.738322] Subtest basic: SUCCESS (0.043s)
[71.806690] [039/162] (923s left) gem_ringfill (basic-all)
[72.101610] Starting subtest: basic-all
[73.335414] Subtest basic-all: SUCCESS (1.175s)
[73.394496] [040/162] (921s left) gem_softpin (allocator-basic)
[73.471878] Starting subtest: allocator-basic
[73.693166] Subtest allocator-basic: SUCCESS (0.165s)
[73.750722] [041/162] (921s left) gem_softpin (allocator-basic-reserve)
[73.823456] Starting subtest: allocator-basic-reserve
[74.041835] Subtest allocator-basic-reserve: SUCCESS (0.163s)
[74.095575] [042/162] (921s left) gem_softpin (safe-alignment)
[74.173711] Starting subtest: safe-alignment
[74.192364] Subtest safe-alignment: SUCCESS (0.019s)
[74.281933] [043/162] (921s left) gem_sync (basic-all)
[74.361747] Starting subtest: basic-all
[76.862143] Subtest basic-all: SUCCESS (2.459s)
[77.003448] [044/162] (918s left) gem_sync (basic-each)
[77.083189] Starting subtest: basic-each
[79.310796] Subtest basic-each: SUCCESS (2.226s)
[79.559476] [045/162] (915s left) gem_tiled_blits (basic)
[79.709211] Starting subtest: basic
[79.726761] Subtest basic: SUCCESS (0.020s)
[79.832585] [046/162] (915s left) gem_tiled_fence_blits (basic)
[80.373048] Starting subtest: basic
[80.383550] Subtest basic: SUCCESS (0.011s)
[80.486663] [047/162] (915s left) gem_tiled_pread_basic (basic)
[80.668052] Starting subtest: basic
[80.855218] Subtest basic: SUCCESS (0.132s)
[80.914976] [048/162] (914s left) gem_wait (busy@all-engines)
[81.004982] Starting subtest: busy
[81.007018] Starting dynamic subtest: all-engines
[81.592841] Dynamic subtest all-engines: SUCCESS (0.587s)
[81.594995] Subtest busy: SUCCESS (0.588s)
[81.890906] [049/162] (913s left) gem_wait (wait@all-engines)
[81.978313] Starting subtest: wait
[81.979427] Starting dynamic subtest: all-engines
[83.068183] Dynamic subtest all-engines: SUCCESS (1.044s)
[83.070608] Subtest wait: SUCCESS (1.044s)
[83.236207] [050/162] (912s left) i915_getparams_basic (basic-eu-total)
[83.302764] Starting subtest: basic-eu-total
[83.304867] Subtest basic-eu-total: SUCCESS (0.000s)
[83.357888] [051/162] (912s left) i915_getparams_basic (basic-subslice-total)
[83.415782] Starting subtest: basic-subslice-total
[83.417942] Subtest basic-subslice-total: SUCCESS (0.000s)
[83.473428] [052/162] (912s left) i915_hangman (error-state-basic)
[83.552549] Starting subtest: error-state-basic
[83.561427] Subtest error-state-basic: SUCCESS (0.008s)
[83.822428] [053/162] (912s left) i915_pciid
[83.989556] [054/162] (912s left) intel_hwmon (hwmon-read)
[84.050478] Subtest hwmon-read: SKIP (0.000s)
[84.107495] [055/162] (912s left) intel_hwmon (hwmon-write)
[84.164778] Subtest hwmon-write: SKIP (0.000s)
[84.220825] [056/162] (912s left) kms_addfb_basic (addfb25-4-tiled)
[84.502901] Starting subtest: addfb25-4-tiled
[84.506998] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[84.588266] [057/162] (911s left) kms_addfb_basic (addfb25-bad-modifier)
[84.856513] Starting subtest: addfb25-bad-modifier
[84.857656] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[84.936176] [058/162] (911s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[85.216665] Starting subtest: addfb25-framebuffer-vs-set-tiling
[85.218138] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[85.297850] [059/162] (911s left) kms_addfb_basic (addfb25-modifier-no-flag)
[85.570517] Starting subtest: addfb25-modifier-no-flag
[85.572476] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[85.678179] [060/162] (910s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[85.953465] Starting subtest: addfb25-x-tiled-legacy
[85.954628] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[86.033419] [061/162] (910s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[86.323164] Starting subtest: addfb25-x-tiled-mismatch-legacy
[86.324903] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[86.420588] [062/162] (910s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[86.700345] Starting subtest: addfb25-yf-tiled-legacy
[86.701423] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[86.791372] [063/162] (910s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[87.074831] Starting subtest: addfb25-y-tiled-legacy
[87.076108] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[87.162819] [064/162] (909s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[87.443941] Starting subtest: addfb25-y-tiled-small-legacy
[87.445145] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[87.525926] [065/162] (909s left) kms_addfb_basic (bad-pitch-0)
[87.585324] Starting subtest: bad-pitch-0
[87.586307] Subtest bad-pitch-0: SUCCESS (0.000s)
[87.874433] [066/162] (909s left) kms_addfb_basic (bad-pitch-1024)
[87.932160] Starting subtest: bad-pitch-1024
[87.933138] Subtest bad-pitch-1024: SUCCESS (0.000s)
[88.237058] [067/162] (908s left) kms_addfb_basic (bad-pitch-128)
[88.297043] Starting subtest: bad-pitch-128
[88.298078] Subtest bad-pitch-128: SUCCESS (0.000s)
[88.589983] [068/162] (908s left) kms_addfb_basic (bad-pitch-256)
[88.649374] Starting subtest: bad-pitch-256
[88.650291] Subtest bad-pitch-256: SUCCESS (0.000s)
[88.956866] [069/162] (908s left) kms_addfb_basic (bad-pitch-32)
[89.015676] Starting subtest: bad-pitch-32
[89.016816] Subtest bad-pitch-32: SUCCESS (0.000s)
[89.307992] [070/162] (907s left) kms_addfb_basic (bad-pitch-63)
[89.366721] Starting subtest: bad-pitch-63
[89.367572] Subtest bad-pitch-63: SUCCESS (0.000s)
[89.673881] [071/162] (907s left) kms_addfb_basic (bad-pitch-65536)
[89.734557] Starting subtest: bad-pitch-65536
[89.735498] Subtest bad-pitch-65536: SUCCESS (0.000s)
[90.032649] [072/162] (907s left) kms_addfb_basic (bad-pitch-999)
[90.090886] Starting subtest: bad-pitch-999
[90.091845] Subtest bad-pitch-999: SUCCESS (0.000s)
[90.381210] [073/162] (907s left) kms_addfb_basic (basic)
[90.439178] Starting subtest: basic
[90.440255] Subtest basic: SUCCESS (0.000s)
[90.735087] [074/162] (906s left) kms_addfb_basic (basic-x-tiled-legacy)
[90.795065] Starting subtest: basic-x-tiled-legacy
[90.795989] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[91.119474] [075/162] (906s left) kms_addfb_basic (basic-y-tiled-legacy)
[91.179232] Starting subtest: basic-y-tiled-legacy
[91.180112] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[91.474813] [076/162] (906s left) kms_addfb_basic (bo-too-small)
[91.748717] Starting subtest: bo-too-small
[91.749978] Subtest bo-too-small: SUCCESS (0.001s)
[91.835135] [077/162] (905s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[92.128116] Starting subtest: bo-too-small-due-to-tiling
[92.129529] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[92.234691] [078/162] (905s left) kms_addfb_basic (clobberred-modifier)
[92.293841] Starting subtest: clobberred-modifier
[92.294799] Subtest clobberred-modifier: SUCCESS (0.000s)
[92.618515] [079/162] (905s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[92.676804] Starting subtest: framebuffer-vs-set-tiling
[92.677864] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.978977] [080/162] (905s left) kms_addfb_basic (invalid-get-prop)
[93.044016] Starting subtest: invalid-get-prop
[93.045477] Subtest invalid-get-prop: SUCCESS (0.000s)
[93.342346] [081/162] (904s left) kms_addfb_basic (invalid-get-prop-any)
[93.401501] Starting subtest: invalid-get-prop-any
[93.402459] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[93.693731] [082/162] (904s left) kms_addfb_basic (invalid-set-prop)
[93.752266] Starting subtest: invalid-set-prop
[93.753205] Subtest invalid-set-prop: SUCCESS (0.000s)
[94.048346] [083/162] (904s left) kms_addfb_basic (invalid-set-prop-any)
[94.106856] Starting subtest: invalid-set-prop-any
[94.107869] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[94.402192] [084/162] (903s left) kms_addfb_basic (no-handle)
[94.461664] Starting subtest: no-handle
[94.463139] Subtest no-handle: SUCCESS (0.000s)
[94.763778] [085/162] (903s left) kms_addfb_basic (size-max)
[95.036270] Starting subtest: size-max
[95.037596] Subtest size-max: SUCCESS (0.001s)
[95.140870] [086/162] (903s left) kms_addfb_basic (small-bo)
[95.418678] Starting subtest: small-bo
[95.420318] Subtest small-bo: SUCCESS (0.000s)
[95.506653] [087/162] (902s left) kms_addfb_basic (tile-pitch-mismatch)
[95.565349] Starting subtest: tile-pitch-mismatch
[95.566231] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[95.863032] [088/162] (902s left) kms_addfb_basic (too-high)
[96.147513] Starting subtest: too-high
[96.148927] Subtest too-high: SUCCESS (0.002s)
[96.228434] [089/162] (902s left) kms_addfb_basic (too-wide)
[96.500480] Starting subtest: too-wide
[96.501636] Subtest too-wide: SUCCESS (0.000s)
[96.591348] [090/162] (902s left) kms_addfb_basic (unused-handle)
[96.650227] Starting subtest: unused-handle
[96.651199] Subtest unused-handle: SUCCESS (0.000s)
[96.953634] [091/162] (901s left) kms_addfb_basic (unused-modifier)
[97.012661] Starting subtest: unused-modifier
[97.014044] Subtest unused-modifier: SUCCESS (0.000s)
[97.332080] [092/162] (901s left) kms_addfb_basic (unused-offsets)
[97.390293] Starting subtest: unused-offsets
[97.391259] Subtest unused-offsets: SUCCESS (0.000s)
[97.693552] [093/162] (901s left) kms_addfb_basic (unused-pitches)
[97.751972] Starting subtest: unused-pitches
[97.752958] Subtest unused-pitches: SUCCESS (0.000s)
[98.054356] [094/162] (900s left) kms_busy (basic)
[98.332464] Subtest basic: SKIP (0.000s)
[98.399242] [095/162] (900s left) kms_prop_blob (basic)
[98.458188] Starting subtest: basic
[98.459092] Subtest basic: SUCCESS (0.000s)
[98.517303] [096/162] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[98.805782] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[98.868866] [097/162] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[99.145106] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[99.209077] [098/162] (899s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[99.491022] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[99.549462] [099/162] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[99.822726] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[99.884308] [100/162] (899s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[100.161298] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[100.218474] [101/162] (899s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[100.506866] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[100.567982] [102/162] (898s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[100.850068] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[100.913027] [103/162] (898s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[101.196146] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[101.260462] [104/162] (898s left) kms_dsc (dsc-basic)
[101.540482] Subtest dsc-basic: SKIP (0.000s)
[101.608789] [105/162] (898s left) kms_flip (basic-flip-vs-dpms)
[101.880709] Starting subtest: basic-flip-vs-dpms
[101.883540] Subtest basic-flip-vs-dpms: SKIP (0.002s)
[101.961996] [106/162] (897s left) kms_flip (basic-flip-vs-modeset)
[102.237186] Starting subtest: basic-flip-vs-modeset
[102.239504] Subtest basic-flip-vs-modeset: SKIP (0.003s)
[102.316589] [107/162] (897s left) kms_flip (basic-flip-vs-wf_vblank)
[102.591251] Starting subtest: basic-flip-vs-wf_vblank
[102.596051] Subtest basic-flip-vs-wf_vblank: SKIP (0.003s)
[102.678565] [108/162] (897s left) kms_flip (basic-plain-flip)
[102.950743] Starting subtest: basic-plain-flip
[102.953925] Subtest basic-plain-flip: SKIP (0.002s)
[103.032841] [109/162] (896s left) kms_force_connector_basic (force-connector-state)
[103.433312] Starting subtest: force-connector-state
[104.226293] Subtest force-connector-state: SUCCESS (0.792s)
[104.844660] [110/162] (895s left) kms_force_connector_basic (force-edid)
[105.236377] Starting subtest: force-edid
[105.894231] Subtest force-edid: SUCCESS (0.659s)
[106.401767] [111/162] (893s left) kms_force_connector_basic (force-load-detect)
[106.796167] Starting subtest: force-load-detect
[106.798372] Subtest force-load-detect: SKIP (0.000s)
[107.191958] [112/162] (892s left) kms_force_connector_basic (prune-stale-modes)
[107.583812] Starting subtest: prune-stale-modes
[108.314393] Subtest prune-stale-modes: SUCCESS (0.731s)
[108.810434] [113/162] (891s left) kms_frontbuffer_tracking (basic)
[109.092829] Subtest basic: SKIP (0.000s)
[109.174979] [114/162] (891s left) kms_hdmi_inject (inject-audio)
[109.237441] Starting subtest: inject-audio
[109.871429] Subtest inject-audio: SUCCESS (0.632s)
[110.119410] [115/162] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[110.394571] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[110.471252] [116/162] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[110.741454] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[110.808656] [117/162] (889s left) kms_pipe_crc_basic (hang-read-crc)
[111.082676] Subtest hang-read-crc: SKIP (0.000s)
[111.149280] [118/162] (889s left) kms_pipe_crc_basic (nonblocking-crc)
[111.432341] Subtest nonblocking-crc: SKIP (0.000s)
[111.512409] [119/162] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[111.782095] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[111.860819] [120/162] (888s left) kms_pipe_crc_basic (read-crc)
[112.135492] Subtest read-crc: SKIP (0.000s)
[112.208834] [121/162] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[112.480259] Subtest read-crc-frame-sequence: SKIP (0.000s)
[112.556241] [122/162] (888s left) kms_pm_backlight (basic-brightness)
[112.840526] Subtest basic-brightness: SKIP (0.000s)
[112.914350] [123/162] (887s left) kms_pm_rpm (basic-pci-d3-state)
[114.575322] Starting subtest: basic-pci-d3-state
[114.892347] Subtest basic-pci-d3-state: SUCCESS (0.316s)
[115.070443] [124/162] (885s left) kms_pm_rpm (basic-rte)
[115.393076] Starting subtest: basic-rte
[117.293495] Subtest basic-rte: SUCCESS (1.901s)
[117.842196] [125/162] (883s left) kms_psr (psr-primary-page-flip)
[118.277068] Subtest psr-primary-page-flip: SKIP (0.000s)
[118.342155] [126/162] (882s left) kms_psr (psr-cursor-plane-move)
[118.621523] Subtest psr-cursor-plane-move: SKIP (0.000s)
[118.690518] [127/162] (882s left) kms_psr (psr-sprite-plane-onoff)
[118.961305] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[119.034524] [128/162] (882s left) kms_psr (psr-primary-mmap-gtt)
[119.309927] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[119.383894] [129/162] (881s left) kms_setmode (basic-clone-single-crtc)
[119.445219] Starting subtest: basic-clone-single-crtc
[119.448253] Subtest basic-clone-single-crtc: SKIP (0.000s)
[119.507797] [130/162] (881s left) i915_pm_rps (basic-api)
[119.579862] Starting subtest: basic-api
[119.584740] Subtest basic-api: SUCCESS (0.005s)
[119.668069] [131/162] (881s left) prime_self_import (basic-llseek-bad)
[119.726589] Starting subtest: basic-llseek-bad
[119.730912] Subtest basic-llseek-bad: SUCCESS (0.004s)
[119.822753] [132/162] (881s left) prime_self_import (basic-llseek-size)
[119.878055] Starting subtest: basic-llseek-size
[119.882174] Subtest basic-llseek-size: SUCCESS (0.004s)
[119.966804] [133/162] (881s left) prime_self_import (basic-with_fd_dup)
[120.022967] Starting subtest: basic-with_fd_dup
[120.027529] Subtest basic-with_fd_dup: SUCCESS (0.005s)
[120.111861] [134/162] (881s left) prime_self_import (basic-with_one_bo)
[120.167470] Starting subtest: basic-with_one_bo
[120.172173] Subtest basic-with_one_bo: SUCCESS (0.004s)
[120.235389] [135/162] (881s left) prime_self_import (basic-with_one_bo_two_files)
[120.291173] Starting subtest: basic-with_one_bo_two_files
[120.295123] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[120.378326] [136/162] (881s left) prime_self_import (basic-with_two_bos)
[120.433886] Starting subtest: basic-with_two_bos
[120.440257] Subtest basic-with_two_bos: SUCCESS (0.005s)
[120.532809] [137/162] (881s left) prime_vgem (basic-fence-flip)
[120.619411] Starting subtest: basic-fence-flip
[120.837809] Subtest basic-fence-flip: SKIP (0.214s)
[120.928670] [138/162] (880s left) prime_vgem (basic-fence-mmap)
[120.996596] Starting subtest: basic-fence-mmap
[121.032533] Subtest basic-fence-mmap: SUCCESS (0.035s)
[121.119513] [139/162] (880s left) prime_vgem (basic-fence-read)
[121.188499] Starting subtest: basic-fence-read
[121.262353] Subtest basic-fence-read: SUCCESS (0.074s)
[121.330450] [140/162] (880s left) prime_vgem (basic-gtt)
[121.399998] Starting subtest: basic-gtt
[121.417838] Subtest basic-gtt: SUCCESS (0.018s)
[121.500719] [141/162] (880s left) prime_vgem (basic-read)
[121.569821] Starting subtest: basic-read
[121.605950] Subtest basic-read: SUCCESS (0.036s)
[121.690304] [142/162] (880s left) prime_vgem (basic-write)
[121.758989] Starting subtest: basic-write
[121.794571] Subtest basic-write: SUCCESS (0.035s)
[121.860498] [143/162] (880s left) vgem_basic (setversion)
[121.923289] Starting subtest: setversion
[121.925160] Subtest setversion: SUCCESS (0.000s)
[121.985356] [144/162] (880s left) vgem_basic (create)
[122.045258] Starting subtest: create
[122.046481] Subtest create: SUCCESS (0.000s)
[122.104897] [145/162] (880s left) vgem_basic (debugfs)
[122.165668] Starting subtest: debugfs
[122.166591] Subtest debugfs: SUCCESS (0.000s)
[122.224472] [146/162] (880s left) vgem_basic (dmabuf-export)
[122.286209] Starting subtest: dmabuf-export
[122.298221] Subtest dmabuf-export: SUCCESS (0.012s)
[122.381061] [147/162] (879s left) vgem_basic (dmabuf-fence)
[122.444314] Starting subtest: dmabuf-fence
[122.445206] Subtest dmabuf-fence: SUCCESS (0.001s)
[122.519032] [148/162] (879s left) vgem_basic (dmabuf-fence-before)
[122.578154] Starting subtest: dmabuf-fence-before
[122.579100] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[122.642287] [149/162] (879s left) vgem_basic (dmabuf-mmap)
[122.702831] Starting subtest: dmabuf-mmap
[122.713469] Subtest dmabuf-mmap: SUCCESS (0.012s)
[122.772580] [150/162] (879s left) vgem_basic (mmap)
[122.834441] Starting subtest: mmap
[122.842093] Subtest mmap: SUCCESS (0.009s)
[122.927096] [151/162] (879s left) vgem_basic (second-client)
[122.987396] Starting subtest: second-client
[122.990297] Subtest second-client: SUCCESS (0.004s)
[123.049258] [152/162] (879s left) vgem_basic (sysfs)
[123.110665] Starting subtest: sysfs
[123.111641] Subtest sysfs: SUCCESS (0.001s)
[123.171747] [153/162] (879s left) core_hotunplug (unbind-rebind)
[123.284606] Starting subtest: unbind-rebind
[127.419111] Subtest unbind-rebind: SUCCESS (4.131s)
[127.475025] [154/162] (875s left) vgem_basic (unload)
[127.537858] Starting subtest: unload
[156.543983] Subtest unload: SUCCESS (28.949s)
[156.600526] [155/162] (846s left) i915_module_load (reload)
[156.665962] Starting subtest: reload
[160.204496] Subtest reload: SUCCESS (3.539s)
[160.296829] [156/162] (842s left) gem_lmem_swapping (basic)
[160.476860] Subtest basic: SKIP (0.000s)
[160.587224] [157/162] (842s left) gem_lmem_swapping (parallel-random-engines)
[160.652546] Subtest parallel-random-engines: SKIP (0.000s)
[160.708542] [158/162] (842s left) gem_lmem_swapping (random-engines)
[160.774579] Subtest random-engines: SKIP (0.000s)
[160.831272] [159/162] (842s left) gem_lmem_swapping (verify-random)
[160.897636] Subtest verify-random: SKIP (0.000s)
[160.953435] [160/162] (842s left) i915_pm_rpm (module-reload)
[163.661201] Starting subtest: module-reload
[177.932546] Subtest module-reload: SUCCESS (14.238s)
[178.000370] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[178.001891] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[178.004857] [161/162] (825s left) i915_selftest (live)