[36.340928] Initializing watchdogs
[36.340998]   /dev/watchdog0
[36.352426] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:3e92 Intel Coffeelake (Gen9) CoffeeLake-S GT2 [UHD Graphics 630]
[36.360297] [001/162] (960s left) i915_module_load (load)
[36.423698] Starting subtest: load
[38.649487] Subtest load: SUCCESS (2.223s)
[38.697552] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[38.699696] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[38.705233] [002/162] (958s left) core_auth (basic-auth)
[38.764830] Starting subtest: basic-auth
[38.768332] Subtest basic-auth: SUCCESS (0.001s)
[38.921820] [003/162] (958s left) core_debugfs (read-all-entries)
[38.970669] Starting subtest: read-all-entries
[39.048352] Subtest read-all-entries: SUCCESS (0.082s)
[39.140496] [004/162] (957s left) core_sysfs (read-all-entries)
[39.185601] Starting subtest: read-all-entries
[39.188620] Subtest read-all-entries: SUCCESS (0.003s)
[39.324893] [005/162] (957s left) fbdev (eof)
[39.383424] Starting subtest: eof
[39.386516] Subtest eof: SUCCESS (0.000s)
[39.551835] [006/162] (957s left) fbdev (info)
[39.596029] Starting subtest: info
[39.598968] Subtest info: SUCCESS (0.000s)
[39.673856] [007/162] (957s left) fbdev (nullptr)
[39.729219] Starting subtest: nullptr
[39.732175] Subtest nullptr: SUCCESS (0.000s)
[39.822253] [008/162] (957s left) fbdev (read)
[39.882134] Starting subtest: read
[40.139804] Subtest read: SUCCESS (0.223s)
[40.524928] [009/162] (957s left) fbdev (write)
[40.849190] Starting subtest: write
[40.979880] Subtest write: SUCCESS (0.117s)
[41.423259] [010/162] (956s left) gem_basic (bad-close)
[41.495391] Starting subtest: bad-close
[41.501919] Subtest bad-close: SUCCESS (0.000s)
[41.582617] [011/162] (956s left) gem_basic (create-close)
[41.630202] Starting subtest: create-close
[41.636536] Subtest create-close: SUCCESS (0.000s)
[41.735515] [012/162] (956s left) gem_basic (create-fd-close)
[41.787305] Starting subtest: create-fd-close
[41.793491] Subtest create-fd-close: SUCCESS (0.000s)
[41.936721] [013/162] (956s left) gem_busy (busy@all-engines)
[41.992085] Starting subtest: busy
[41.995194] Starting dynamic subtest: all-engines
[42.016843] Dynamic subtest all-engines: SUCCESS (0.024s)
[42.020224] Subtest busy: SUCCESS (0.025s)
[42.436649] [014/162] (956s left) gem_close_race (basic-process)
[42.489061] Starting subtest: basic-process
[42.553416] Subtest basic-process: SUCCESS (0.064s)
[42.801771] [015/162] (955s left) gem_close_race (basic-threads)
[42.854664] Starting subtest: basic-threads
[44.042221] Subtest basic-threads: SUCCESS (1.185s)
[44.305364] [016/162] (954s left) gem_ctx_create (basic)
[44.365161] Starting subtest: basic
[44.368572] Subtest basic: SUCCESS (0.000s)
[44.590504] [017/162] (954s left) gem_ctx_create (basic-files)
[44.639836] Starting subtest: basic-files
[46.649800] Subtest basic-files: SUCCESS (2.005s)
[46.930680] [018/162] (951s left) gem_ctx_exec (basic)
[46.978597] Starting subtest: basic
[46.981746] Subtest basic: SUCCESS (0.003s)
[47.145929] [019/162] (951s left) gem_exec_basic (basic)
[47.191279] Starting subtest: basic
[47.194160] Starting dynamic subtest: rcs0-smem
[47.197236] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[47.206513] Starting dynamic subtest: bcs0-smem
[47.209688] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[47.218903] Starting dynamic subtest: vcs0-smem
[47.222075] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[47.231067] Starting dynamic subtest: vecs0-smem
[47.234202] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[47.237443] Subtest basic: SUCCESS (0.004s)
[47.415478] [020/162] (951s left) gem_exec_create (basic)
[47.475172] Starting subtest: basic
[47.478103] Starting dynamic subtest: smem
[49.524218] Dynamic subtest smem: SUCCESS (2.045s)
[49.527465] Subtest basic: SUCCESS (2.045s)
[49.721453] [021/162] (949s left) gem_exec_fence (basic-busy)
[50.034423] Starting subtest: basic-busy
[50.099257] Starting dynamic subtest: rcs0
[50.228751] Dynamic subtest rcs0: SUCCESS (0.039s)
[50.294233] Starting dynamic subtest: bcs0
[50.426321] Dynamic subtest bcs0: SUCCESS (0.049s)
[50.492040] Starting dynamic subtest: vcs0
[50.623970] Dynamic subtest vcs0: SUCCESS (0.038s)
[50.722227] Starting dynamic subtest: vecs0
[50.855457] Dynamic subtest vecs0: SUCCESS (0.035s)
[50.922193] Subtest basic-busy: SUCCESS (0.167s)
[51.398671] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[51.402614] [022/162] (947s left) gem_exec_fence (basic-wait)
[51.567977] Starting subtest: basic-wait
[51.571264] Starting dynamic subtest: rcs0
[51.596273] Dynamic subtest rcs0: SUCCESS (0.028s)
[51.609217] Starting dynamic subtest: bcs0
[51.625981] Dynamic subtest bcs0: SUCCESS (0.029s)
[51.638244] Starting dynamic subtest: vcs0
[51.656099] Dynamic subtest vcs0: SUCCESS (0.030s)
[51.674438] Starting dynamic subtest: vecs0
[51.684339] Dynamic subtest vecs0: SUCCESS (0.027s)
[51.687984] Subtest basic-wait: SUCCESS (0.117s)
[52.277960] [023/162] (946s left) gem_exec_fence (basic-await)
[52.445206] Starting subtest: basic-await
[52.448171] Starting dynamic subtest: rcs0
[52.516977] Dynamic subtest rcs0: SUCCESS (0.074s)
[52.534701] Starting dynamic subtest: bcs0
[52.608147] Dynamic subtest bcs0: SUCCESS (0.090s)
[52.627486] Starting dynamic subtest: vcs0
[52.699981] Dynamic subtest vcs0: SUCCESS (0.091s)
[52.717902] Starting dynamic subtest: vecs0
[52.790100] Dynamic subtest vecs0: SUCCESS (0.089s)
[52.793672] Subtest basic-await: SUCCESS (0.348s)
[53.323868] [024/162] (945s left) gem_exec_fence (nb-await)
[53.487390] Starting subtest: nb-await
[53.490592] Starting dynamic subtest: rcs0
[53.551188] Dynamic subtest rcs0: SUCCESS (0.062s)
[53.586000] Starting dynamic subtest: bcs0
[53.632223] Dynamic subtest bcs0: SUCCESS (0.079s)
[53.666546] Starting dynamic subtest: vcs0
[53.713326] Dynamic subtest vcs0: SUCCESS (0.080s)
[53.746842] Starting dynamic subtest: vecs0
[53.790529] Dynamic subtest vecs0: SUCCESS (0.076s)
[53.794537] Subtest nb-await: SUCCESS (0.303s)
[54.325336] [025/162] (944s left) gem_exec_gttfill (basic)
[54.378524] Starting subtest: basic
[59.657122] Subtest basic: SUCCESS (5.273s)
[59.846545] [026/162] (939s left) gem_exec_parallel (engines)
[59.972275] Starting subtest: engines
[59.975400] Starting dynamic subtest: basic
[61.852052] Dynamic subtest basic: SUCCESS (1.878s)
[61.862686] Starting dynamic subtest: contexts
[64.712573] Dynamic subtest contexts: SUCCESS (2.858s)
[64.723596] Starting dynamic subtest: fds
[66.853570] Dynamic subtest fds: SUCCESS (2.140s)
[66.864201] Starting dynamic subtest: userptr
[69.385248] Dynamic subtest userptr: SUCCESS (2.530s)
[69.388523] Subtest engines: SUCCESS (9.407s)
[69.642736] [027/162] (929s left) gem_exec_store (basic)
[69.699551] Starting subtest: basic
[69.752237] Subtest basic: SUCCESS (0.058s)
[69.978133] [028/162] (929s left) gem_flink_basic (bad-flink)
[70.024199] Starting subtest: bad-flink
[70.027630] Subtest bad-flink: SUCCESS (0.000s)
[70.126474] [029/162] (929s left) gem_flink_basic (bad-open)
[70.176564] Starting subtest: bad-open
[70.179687] Subtest bad-open: SUCCESS (0.000s)
[70.279530] [030/162] (929s left) gem_flink_basic (basic)
[70.327271] Starting subtest: basic
[70.331200] Subtest basic: SUCCESS (0.000s)
[70.508225] [031/162] (929s left) gem_flink_basic (double-flink)
[70.559591] Starting subtest: double-flink
[70.563138] Subtest double-flink: SUCCESS (0.000s)
[70.728537] [032/162] (929s left) gem_flink_basic (flink-lifetime)
[70.774976] Starting subtest: flink-lifetime
[70.778453] Subtest flink-lifetime: SUCCESS (0.001s)
[70.906138] [033/162] (928s left) gem_huc_copy (huc-copy)
[70.990152] Starting subtest: huc-copy
[70.997637] Subtest huc-copy: SUCCESS (0.007s)
[71.178680] [034/162] (928s left) gem_linear_blits (basic)
[71.304491] Starting subtest: basic
[71.310138] Subtest basic: SUCCESS (0.008s)
[71.520780] [035/162] (928s left) gem_mmap (basic)
[71.657884] Starting subtest: basic
[71.674129] Subtest basic: SUCCESS (0.000s)
[71.807277] [036/162] (928s left) gem_mmap_gtt (basic)
[71.855705] Starting subtest: basic
[71.859047] Subtest basic: SUCCESS (0.001s)
[72.009759] [037/162] (928s left) gem_render_linear_blits (basic)
[72.056811] Starting subtest: basic
[72.079405] Subtest basic: SUCCESS (0.024s)
[72.166286] [038/162] (928s left) gem_render_tiled_blits (basic)
[72.222244] Starting subtest: basic
[72.248288] Subtest basic: SUCCESS (0.029s)
[72.329583] [039/162] (928s left) gem_ringfill (basic-all)
[72.561275] Starting subtest: basic-all
[73.705806] Subtest basic-all: SUCCESS (1.137s)
[73.827511] [040/162] (926s left) gem_softpin (allocator-basic)
[73.872048] Starting subtest: allocator-basic
[73.961598] Subtest allocator-basic: SUCCESS (0.086s)
[74.125811] [041/162] (926s left) gem_softpin (allocator-basic-reserve)
[74.173288] Starting subtest: allocator-basic-reserve
[74.255831] Subtest allocator-basic-reserve: SUCCESS (0.085s)
[74.375339] [042/162] (926s left) gem_softpin (safe-alignment)
[74.425598] Starting subtest: safe-alignment
[74.432266] Subtest safe-alignment: SUCCESS (0.010s)
[74.606801] [043/162] (925s left) gem_sync (basic-all)
[74.672514] Starting subtest: basic-all
[76.794108] Subtest basic-all: SUCCESS (2.135s)
[77.025425] [044/162] (923s left) gem_sync (basic-each)
[77.096729] Starting subtest: basic-each
[79.143136] Subtest basic-each: SUCCESS (2.066s)
[79.418456] [045/162] (921s left) gem_tiled_blits (basic)
[79.505738] Starting subtest: basic
[79.524069] Subtest basic: SUCCESS (0.018s)
[79.722389] [046/162] (921s left) gem_tiled_fence_blits (basic)
[79.893744] Starting subtest: basic
[79.905190] Subtest basic: SUCCESS (0.011s)
[80.107371] [047/162] (920s left) gem_tiled_pread_basic (basic)
[80.243066] Starting subtest: basic
[80.346525] Subtest basic: SUCCESS (0.110s)
[80.490130] [048/162] (920s left) gem_wait (busy@all-engines)
[80.542945] Starting subtest: busy
[80.546162] Starting dynamic subtest: all-engines
[81.059985] Dynamic subtest all-engines: SUCCESS (0.517s)
[81.063201] Subtest busy: SUCCESS (0.517s)
[81.266800] [049/162] (919s left) gem_wait (wait@all-engines)
[81.321551] Starting subtest: wait
[81.324739] Starting dynamic subtest: all-engines
[82.360881] Dynamic subtest all-engines: SUCCESS (1.039s)
[82.364091] Subtest wait: SUCCESS (1.040s)
[82.566877] [050/162] (918s left) i915_getparams_basic (basic-eu-total)
[82.616386] Starting subtest: basic-eu-total
[82.622962] Subtest basic-eu-total: SUCCESS (0.000s)
[82.717725] [051/162] (918s left) i915_getparams_basic (basic-subslice-total)
[82.759601] Starting subtest: basic-subslice-total
[82.765939] Subtest basic-subslice-total: SUCCESS (0.000s)
[82.900261] [052/162] (918s left) i915_hangman (error-state-basic)
[82.950276] Starting subtest: error-state-basic
[83.013328] Subtest error-state-basic: SUCCESS (0.060s)
[83.096142] [053/162] (918s left) i915_pciid
[83.248131] [054/162] (918s left) intel_hwmon (hwmon-read)
[83.295425] Subtest hwmon-read: SKIP (0.000s)
[83.345886] [055/162] (917s left) intel_hwmon (hwmon-write)
[83.400693] Subtest hwmon-write: SKIP (0.000s)
[83.447137] [056/162] (917s left) kms_addfb_basic (addfb25-4-tiled)
[83.570377] Starting subtest: addfb25-4-tiled
[83.573500] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[83.710949] [057/162] (917s left) kms_addfb_basic (addfb25-bad-modifier)
[83.822899] Starting subtest: addfb25-bad-modifier
[83.826020] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[83.927953] [058/162] (917s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[84.041266] Starting subtest: addfb25-framebuffer-vs-set-tiling
[84.044576] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[84.173725] [059/162] (917s left) kms_addfb_basic (addfb25-modifier-no-flag)
[84.285585] Starting subtest: addfb25-modifier-no-flag
[84.288872] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[84.429087] [060/162] (917s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[84.540358] Starting subtest: addfb25-x-tiled-legacy
[84.543407] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[84.645807] [061/162] (917s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[84.755188] Starting subtest: addfb25-x-tiled-mismatch-legacy
[84.757950] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[84.889382] [062/162] (916s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[84.998086] Starting subtest: addfb25-yf-tiled-legacy
[85.000817] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[85.145529] [063/162] (916s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[85.259368] Starting subtest: addfb25-y-tiled-legacy
[85.262021] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[85.450898] [064/162] (916s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[85.561134] Starting subtest: addfb25-y-tiled-small-legacy
[85.564007] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[85.746367] [065/162] (916s left) kms_addfb_basic (bad-pitch-0)
[85.794169] Starting subtest: bad-pitch-0
[85.797176] Subtest bad-pitch-0: SUCCESS (0.000s)
[85.990219] [066/162] (916s left) kms_addfb_basic (bad-pitch-1024)
[86.040867] Starting subtest: bad-pitch-1024
[86.044070] Subtest bad-pitch-1024: SUCCESS (0.000s)
[86.240579] [067/162] (915s left) kms_addfb_basic (bad-pitch-128)
[86.288505] Starting subtest: bad-pitch-128
[86.291670] Subtest bad-pitch-128: SUCCESS (0.000s)
[86.501255] [068/162] (915s left) kms_addfb_basic (bad-pitch-256)
[86.549380] Starting subtest: bad-pitch-256
[86.552507] Subtest bad-pitch-256: SUCCESS (0.000s)
[86.738578] [069/162] (915s left) kms_addfb_basic (bad-pitch-32)
[86.786963] Starting subtest: bad-pitch-32
[86.790622] Subtest bad-pitch-32: SUCCESS (0.000s)
[86.959617] [070/162] (915s left) kms_addfb_basic (bad-pitch-63)
[87.005303] Starting subtest: bad-pitch-63
[87.008502] Subtest bad-pitch-63: SUCCESS (0.000s)
[87.182253] [071/162] (915s left) kms_addfb_basic (bad-pitch-65536)
[87.229488] Starting subtest: bad-pitch-65536
[87.232592] Subtest bad-pitch-65536: SUCCESS (0.000s)
[87.455652] [072/162] (915s left) kms_addfb_basic (bad-pitch-999)
[87.502376] Starting subtest: bad-pitch-999
[87.505467] Subtest bad-pitch-999: SUCCESS (0.000s)
[87.685695] [073/162] (914s left) kms_addfb_basic (basic)
[87.732181] Starting subtest: basic
[87.735327] Subtest basic: SUCCESS (0.000s)
[87.981657] [074/162] (914s left) kms_addfb_basic (basic-x-tiled-legacy)
[88.029878] Starting subtest: basic-x-tiled-legacy
[88.033169] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[88.384433] [075/162] (914s left) kms_addfb_basic (basic-y-tiled-legacy)
[88.778301] Starting subtest: basic-y-tiled-legacy
[88.844856] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[89.337952] [076/162] (913s left) kms_addfb_basic (bo-too-small)
[89.753873] Starting subtest: bo-too-small
[89.758192] Subtest bo-too-small: SUCCESS (0.000s)
[89.849202] [077/162] (913s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[89.959446] Starting subtest: bo-too-small-due-to-tiling
[89.962433] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[90.116635] [078/162] (913s left) kms_addfb_basic (clobberred-modifier)
[90.162830] Starting subtest: clobberred-modifier
[90.165560] Subtest clobberred-modifier: SUCCESS (0.000s)
[90.351384] [079/162] (913s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[90.396969] Starting subtest: framebuffer-vs-set-tiling
[90.399810] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[90.646994] [080/162] (912s left) kms_addfb_basic (invalid-get-prop)
[90.695287] Starting subtest: invalid-get-prop
[90.697997] Subtest invalid-get-prop: SUCCESS (0.000s)
[90.921946] [081/162] (912s left) kms_addfb_basic (invalid-get-prop-any)
[90.968342] Starting subtest: invalid-get-prop-any
[90.971231] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[91.186381] [082/162] (912s left) kms_addfb_basic (invalid-set-prop)
[91.232258] Starting subtest: invalid-set-prop
[91.235193] Subtest invalid-set-prop: SUCCESS (0.000s)
[91.451777] [083/162] (912s left) kms_addfb_basic (invalid-set-prop-any)
[91.498529] Starting subtest: invalid-set-prop-any
[91.501563] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[91.686340] [084/162] (912s left) kms_addfb_basic (no-handle)
[91.734974] Starting subtest: no-handle
[91.750423] Subtest no-handle: SUCCESS (0.000s)
[91.952520] [085/162] (912s left) kms_addfb_basic (size-max)
[92.064119] Starting subtest: size-max
[92.066864] Subtest size-max: SUCCESS (0.000s)
[92.216781] [086/162] (911s left) kms_addfb_basic (small-bo)
[92.327838] Starting subtest: small-bo
[92.330520] Subtest small-bo: SUCCESS (0.000s)
[92.481603] [087/162] (911s left) kms_addfb_basic (tile-pitch-mismatch)
[92.528513] Starting subtest: tile-pitch-mismatch
[92.531650] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[92.720757] [088/162] (911s left) kms_addfb_basic (too-high)
[92.831884] Starting subtest: too-high
[92.834571] Subtest too-high: SUCCESS (0.001s)
[93.012289] [089/162] (911s left) kms_addfb_basic (too-wide)
[93.124191] Starting subtest: too-wide
[93.126795] Subtest too-wide: SUCCESS (0.000s)
[93.292460] [090/162] (911s left) kms_addfb_basic (unused-handle)
[93.338469] Starting subtest: unused-handle
[93.341415] Subtest unused-handle: SUCCESS (0.000s)
[93.549854] [091/162] (910s left) kms_addfb_basic (unused-modifier)
[93.594855] Starting subtest: unused-modifier
[93.597898] Subtest unused-modifier: SUCCESS (0.000s)
[93.790781] [092/162] (910s left) kms_addfb_basic (unused-offsets)
[93.839987] Starting subtest: unused-offsets
[93.843082] Subtest unused-offsets: SUCCESS (0.000s)
[94.051640] [093/162] (910s left) kms_addfb_basic (unused-pitches)
[94.100317] Starting subtest: unused-pitches
[94.103208] Subtest unused-pitches: SUCCESS (0.000s)
[94.290705] [094/162] (910s left) kms_busy (basic)
[94.404490] Starting subtest: basic
[94.407177] Starting dynamic subtest: flip
[95.025159] Dynamic subtest flip: SUCCESS (0.617s)
[95.039400] Starting dynamic subtest: modeset
[95.738074] Dynamic subtest modeset: SUCCESS (0.713s)
[95.741309] Subtest basic: SUCCESS (1.332s)
[95.977856] [095/162] (908s left) kms_prop_blob (basic)
[96.027609] Starting subtest: basic
[96.030804] Subtest basic: SUCCESS (0.000s)
[96.121652] [096/162] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[96.231904] Starting subtest: basic-busy-flip-before-cursor-atomic
[96.237636] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[96.371587] [097/162] (908s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[96.484329] Starting subtest: basic-busy-flip-before-cursor-legacy
[96.489752] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[96.586144] [098/162] (908s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[96.697177] Starting subtest: basic-flip-after-cursor-atomic
[97.772314] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.951s)
[98.248479] [099/162] (907s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[98.381813] Starting subtest: basic-flip-after-cursor-legacy
[99.333150] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.950s)
[99.496471] [100/162] (905s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[99.606200] Starting subtest: basic-flip-after-cursor-varying-size
[100.557474] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.951s)
[100.788754] [101/162] (904s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[100.899238] Starting subtest: basic-flip-before-cursor-atomic
[101.875337] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.976s)
[102.059227] [102/162] (903s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[102.172016] Starting subtest: basic-flip-before-cursor-legacy
[103.123609] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.954s)
[103.343776] [103/162] (902s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[103.458640] Starting subtest: basic-flip-before-cursor-varying-size
[104.430448] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.971s)
[104.620222] [104/162] (901s left) kms_dsc (dsc-basic)
[104.735964] Subtest dsc-basic: SKIP (0.000s)
[104.778876] [105/162] (900s left) kms_flip (basic-flip-vs-dpms)
[104.892691] Starting subtest: basic-flip-vs-dpms
[104.895718] Starting dynamic subtest: A-HDMI-A1
[105.824171] Dynamic subtest A-HDMI-A1: SUCCESS (0.931s)
[105.837440] Starting dynamic subtest: B-HDMI-A1
[106.674460] Dynamic subtest B-HDMI-A1: SUCCESS (0.849s)
[106.693407] Starting dynamic subtest: C-HDMI-A1
[107.555538] Dynamic subtest C-HDMI-A1: SUCCESS (0.879s)
[107.558213] Subtest basic-flip-vs-dpms: SUCCESS (2.666s)
[107.725675] [106/162] (898s left) kms_flip (basic-flip-vs-modeset)
[107.843594] Starting subtest: basic-flip-vs-modeset
[107.846251] Starting dynamic subtest: A-HDMI-A1
[108.810165] Dynamic subtest A-HDMI-A1: SUCCESS (0.962s)
[108.825420] Starting dynamic subtest: B-HDMI-A1
[109.697601] Dynamic subtest B-HDMI-A1: SUCCESS (0.891s)
[109.710013] Starting dynamic subtest: C-HDMI-A1
[110.583187] Dynamic subtest C-HDMI-A1: SUCCESS (0.883s)
[110.585968] Subtest basic-flip-vs-modeset: SUCCESS (2.742s)
[110.748250] [107/162] (895s left) kms_flip (basic-flip-vs-wf_vblank)
[110.864715] Starting subtest: basic-flip-vs-wf_vblank
[110.867326] Starting dynamic subtest: A-HDMI-A1
[112.184133] Dynamic subtest A-HDMI-A1: SUCCESS (1.154s)
[112.249569] Starting dynamic subtest: B-HDMI-A1
[113.181032] Dynamic subtest B-HDMI-A1: SUCCESS (1.161s)
[113.193551] Starting dynamic subtest: C-HDMI-A1
[114.341200] Dynamic subtest C-HDMI-A1: SUCCESS (1.157s)
[114.344326] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.478s)
[114.644226] [108/162] (891s left) kms_flip (basic-plain-flip)
[114.758450] Starting subtest: basic-plain-flip
[114.761466] Starting dynamic subtest: A-HDMI-A1
[115.627630] Dynamic subtest A-HDMI-A1: SUCCESS (0.868s)
[115.638960] Starting dynamic subtest: B-HDMI-A1
[116.504260] Dynamic subtest B-HDMI-A1: SUCCESS (0.875s)
[116.515406] Starting dynamic subtest: C-HDMI-A1
[117.372869] Dynamic subtest C-HDMI-A1: SUCCESS (0.870s)
[117.376032] Subtest basic-plain-flip: SUCCESS (2.618s)
[117.677816] [109/162] (888s left) kms_force_connector_basic (force-connector-state)
[117.825882] Starting subtest: force-connector-state
[118.148585] Subtest force-connector-state: SUCCESS (0.321s)
[118.542517] [110/162] (887s left) kms_force_connector_basic (force-edid)
[118.688908] Starting subtest: force-edid
[118.825842] Subtest force-edid: SUCCESS (0.136s)
[119.025886] [111/162] (887s left) kms_force_connector_basic (force-load-detect)
[119.172435] Starting subtest: force-load-detect
[119.178493] Subtest force-load-detect: SKIP (0.000s)
[119.379233] [112/162] (886s left) kms_force_connector_basic (prune-stale-modes)
[119.519478] Starting subtest: prune-stale-modes
[119.657645] Subtest prune-stale-modes: SUCCESS (0.137s)
[119.856696] [113/162] (886s left) kms_frontbuffer_tracking (basic)
[119.980572] Starting subtest: basic
[122.596241] Subtest basic: SUCCESS (2.624s)
[122.731343] [114/162] (883s left) kms_hdmi_inject (inject-audio)
[122.835032] Starting subtest: inject-audio
[122.952495] Subtest inject-audio: SUCCESS (0.117s)
[123.157911] [115/162] (883s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[123.272343] Starting subtest: compare-crc-sanitycheck-xr24
[123.275415] Starting dynamic subtest: pipe-A-HDMI-A-1
[123.712298] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.439s)
[123.724439] Starting dynamic subtest: pipe-B-HDMI-A-1
[124.107376] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.394s)
[124.119708] Starting dynamic subtest: pipe-C-HDMI-A-1
[124.508480] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.397s)
[124.511434] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.236s)
[124.701911] [116/162] (881s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[124.813776] Starting subtest: compare-crc-sanitycheck-nv12
[124.816814] Starting dynamic subtest: pipe-A-HDMI-A-1
[125.288490] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.473s)
[125.300549] Starting dynamic subtest: pipe-B-HDMI-A-1
[125.715341] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.424s)
[125.727447] Starting dynamic subtest: pipe-C-HDMI-A-1
[125.733383] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[125.736490] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.902s)
[125.909710] [117/162] (880s left) kms_pipe_crc_basic (hang-read-crc)
[126.019237] Starting subtest: hang-read-crc
[126.022168] Starting dynamic subtest: pipe-A-HDMI-A-1
[127.093510] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.075s)
[127.105404] Starting dynamic subtest: pipe-B-HDMI-A-1
[128.068517] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.972s)
[128.080149] Starting dynamic subtest: pipe-C-HDMI-A-1
[129.056041] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.987s)
[129.059112] Subtest hang-read-crc: SUCCESS (3.039s)
[129.217925] [118/162] (877s left) kms_pipe_crc_basic (nonblocking-crc)
[129.333711] Starting subtest: nonblocking-crc
[129.336306] Starting dynamic subtest: pipe-A-HDMI-A-1
[129.909986] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.573s)
[129.933840] Starting dynamic subtest: pipe-B-HDMI-A-1
[130.451044] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.540s)
[130.464203] Starting dynamic subtest: pipe-C-HDMI-A-1
[131.043614] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.588s)
[131.048676] Subtest nonblocking-crc: SUCCESS (1.711s)
[131.262255] [119/162] (875s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[131.415341] Starting subtest: nonblocking-crc-frame-sequence
[131.418154] Starting dynamic subtest: pipe-A-HDMI-A-1
[131.996595] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.579s)
[132.009927] Starting dynamic subtest: pipe-B-HDMI-A-1
[132.521171] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.524s)
[132.534698] Starting dynamic subtest: pipe-C-HDMI-A-1
[133.049180] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.523s)
[133.053436] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.634s)
[133.231758] [120/162] (873s left) kms_pipe_crc_basic (read-crc)
[133.343937] Starting subtest: read-crc
[133.346641] Starting dynamic subtest: pipe-A-HDMI-A-1
[133.889035] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.542s)
[133.900908] Starting dynamic subtest: pipe-B-HDMI-A-1
[134.343910] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.454s)
[134.358173] Starting dynamic subtest: pipe-C-HDMI-A-1
[134.823180] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.477s)
[134.826145] Subtest read-crc: SUCCESS (1.479s)
[134.983710] [121/162] (871s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[135.092867] Starting subtest: read-crc-frame-sequence
[135.095461] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.604216] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.508s)
[135.618134] Starting dynamic subtest: pipe-B-HDMI-A-1
[136.081544] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.474s)
[136.093119] Starting dynamic subtest: pipe-C-HDMI-A-1
[136.535047] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.453s)
[136.538079] Subtest read-crc-frame-sequence: SUCCESS (1.441s)
[136.698483] [122/162] (870s left) kms_pm_backlight (basic-brightness)
[136.841558] Subtest basic-brightness: SKIP (0.000s)
[136.887547] [123/162] (870s left) kms_pm_rpm (basic-pci-d3-state)
[138.442952] Starting subtest: basic-pci-d3-state
[138.704182] Subtest basic-pci-d3-state: SUCCESS (0.355s)
[138.844403] [124/162] (868s left) kms_pm_rpm (basic-rte)
[138.891576] Starting subtest: basic-rte
[140.618065] Subtest basic-rte: SUCCESS (1.723s)
[141.141662] [125/162] (865s left) kms_psr (psr-primary-page-flip)
[141.254291] Subtest psr-primary-page-flip: SKIP (0.000s)
[141.307888] [126/162] (865s left) kms_psr (psr-cursor-plane-move)
[141.418290] Subtest psr-cursor-plane-move: SKIP (0.000s)
[141.481791] [127/162] (865s left) kms_psr (psr-sprite-plane-onoff)
[141.596480] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[141.643705] [128/162] (865s left) kms_psr (psr-primary-mmap-gtt)
[141.755289] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[141.810821] [129/162] (865s left) kms_setmode (basic-clone-single-crtc)
[141.862859] Starting subtest: basic-clone-single-crtc
[141.872383] Subtest basic-clone-single-crtc: SKIP (0.000s)
[141.981958] [130/162] (865s left) i915_pm_rps (basic-api)
[142.033841] Starting subtest: basic-api
[142.037071] Subtest basic-api: SUCCESS (0.003s)
[142.191669] [131/162] (865s left) prime_self_import (basic-llseek-bad)
[142.237213] Starting subtest: basic-llseek-bad
[142.243177] Subtest basic-llseek-bad: SUCCESS (0.002s)
[142.417726] [132/162] (865s left) prime_self_import (basic-llseek-size)
[142.461565] Starting subtest: basic-llseek-size
[142.467901] Subtest basic-llseek-size: SUCCESS (0.002s)
[142.647555] [133/162] (864s left) prime_self_import (basic-with_fd_dup)
[142.692192] Starting subtest: basic-with_fd_dup
[142.698460] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[142.878144] [134/162] (864s left) prime_self_import (basic-with_one_bo)
[142.924860] Starting subtest: basic-with_one_bo
[142.931270] Subtest basic-with_one_bo: SUCCESS (0.002s)
[143.087131] [135/162] (864s left) prime_self_import (basic-with_one_bo_two_files)
[143.135386] Starting subtest: basic-with_one_bo_two_files
[143.142129] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[143.297019] [136/162] (864s left) prime_self_import (basic-with_two_bos)
[143.341995] Starting subtest: basic-with_two_bos
[143.348545] Subtest basic-with_two_bos: SUCCESS (0.003s)
[143.478802] [137/162] (864s left) prime_vgem (basic-fence-flip)
[143.554962] Starting subtest: basic-fence-flip
[143.952227] Subtest basic-fence-flip: SUCCESS (0.397s)
[144.127883] [138/162] (863s left) prime_vgem (basic-fence-mmap)
[144.211220] Starting subtest: basic-fence-mmap
[144.227102] Subtest basic-fence-mmap: SUCCESS (0.021s)
[144.417348] [139/162] (863s left) prime_vgem (basic-fence-read)
[144.485506] Starting subtest: basic-fence-read
[144.524800] Subtest basic-fence-read: SUCCESS (0.040s)
[144.702062] [140/162] (863s left) prime_vgem (basic-gtt)
[144.761115] Starting subtest: basic-gtt
[144.766997] Subtest basic-gtt: SUCCESS (0.009s)
[144.967728] [141/162] (863s left) prime_vgem (basic-read)
[145.024722] Starting subtest: basic-read
[145.043121] Subtest basic-read: SUCCESS (0.019s)
[145.169021] [142/162] (863s left) prime_vgem (basic-write)
[145.225391] Starting subtest: basic-write
[145.242329] Subtest basic-write: SUCCESS (0.018s)
[145.346132] [143/162] (862s left) vgem_basic (setversion)
[145.408882] Starting subtest: setversion
[145.414884] Subtest setversion: SUCCESS (0.000s)
[145.515815] [144/162] (862s left) vgem_basic (create)
[145.571440] Starting subtest: create
[145.574457] Subtest create: SUCCESS (0.000s)
[145.662707] [145/162] (862s left) vgem_basic (debugfs)
[145.729086] Starting subtest: debugfs
[145.731990] Subtest debugfs: SUCCESS (0.001s)
[145.800687] [146/162] (862s left) vgem_basic (dmabuf-export)
[145.858978] Starting subtest: dmabuf-export
[145.865470] Subtest dmabuf-export: SUCCESS (0.002s)
[146.016987] [147/162] (862s left) vgem_basic (dmabuf-fence)
[146.071998] Starting subtest: dmabuf-fence
[146.075198] Subtest dmabuf-fence: SUCCESS (0.000s)
[146.181390] [148/162] (862s left) vgem_basic (dmabuf-fence-before)
[146.238685] Starting subtest: dmabuf-fence-before
[146.242134] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[146.371711] [149/162] (862s left) vgem_basic (dmabuf-mmap)
[146.423620] Starting subtest: dmabuf-mmap
[146.430635] Subtest dmabuf-mmap: SUCCESS (0.007s)
[146.495281] [150/162] (862s left) vgem_basic (mmap)
[146.558238] Starting subtest: mmap
[146.561427] Subtest mmap: SUCCESS (0.005s)
[146.651038] [151/162] (862s left) vgem_basic (second-client)
[146.708189] Starting subtest: second-client
[146.738609] Subtest second-client: SUCCESS (0.033s)
[146.867416] [152/162] (862s left) vgem_basic (sysfs)
[146.921716] Starting subtest: sysfs
[146.925238] Subtest sysfs: SUCCESS (0.000s)
[147.019501] [153/162] (861s left) core_hotunplug (unbind-rebind)
[147.136815] Starting subtest: unbind-rebind
[151.103829] Subtest unbind-rebind: SUCCESS (3.968s)
[151.147234] [154/162] (857s left) vgem_basic (unload)
[151.199236] Starting subtest: unload
[180.152730] Subtest unload: SUCCESS (28.955s)
[180.297709] [155/162] (828s left) i915_module_load (reload)
[180.345444] Starting subtest: reload
[183.366616] Subtest reload: SUCCESS (3.026s)
[183.409812] [156/162] (825s left) gem_lmem_swapping (basic)
[183.472495] Subtest basic: SKIP (0.000s)
[183.564036] [157/162] (825s left) gem_lmem_swapping (parallel-random-engines)
[183.634567] Subtest parallel-random-engines: SKIP (0.000s)
[183.679072] [158/162] (825s left) gem_lmem_swapping (random-engines)
[183.729870] Subtest random-engines: SKIP (0.000s)
[183.774726] [159/162] (825s left) gem_lmem_swapping (verify-random)
[183.827544] Subtest verify-random: SKIP (0.000s)
[183.879031] [160/162] (825s left) i915_pm_rpm (module-reload)
[185.588037] Starting subtest: module-reload
[194.220111] Subtest module-reload: SUCCESS (8.779s)
[194.250540] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[194.251443] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[194.255694] [161/162] (815s left) i915_selftest (live)