[35.147602] Initializing watchdogs [35.147660] /dev/watchdog0 [35.158769] [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] [35.163277] [001/161] (960s left) i915_module_load (load) [35.340074] Starting subtest: load [37.237702] Subtest load: SUCCESS (1.898s) [37.261630] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [37.263470] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [37.266337] [002/161] (958s left) core_auth (basic-auth) [37.343891] Starting subtest: basic-auth [37.345948] Subtest basic-auth: SUCCESS (0.002s) [37.428583] [003/161] (958s left) debugfs_test (read_all_entries) [37.475570] Starting subtest: read_all_entries [37.541773] Subtest read_all_entries: SUCCESS (0.065s) [37.748255] [004/161] (958s left) debugfs_test (basic-hwmon) [37.795857] Starting subtest: basic-hwmon [37.798873] Subtest basic-hwmon: SKIP (0.000s) [37.943335] [005/161] (957s left) debugfs_test (sysfs) [37.993913] Starting subtest: sysfs [38.035098] Subtest sysfs: SUCCESS (0.040s) [38.169772] [006/161] (957s left) fbdev (eof) [38.221900] Starting subtest: eof [38.223679] Subtest eof: SUCCESS (0.000s) [38.306203] [007/161] (957s left) fbdev (info) [38.347684] Starting subtest: info [38.349221] Subtest info: SUCCESS (0.000s) [38.442085] [008/161] (957s left) fbdev (nullptr) [38.488327] Starting subtest: nullptr [38.489988] Subtest nullptr: SUCCESS (0.000s) [38.550846] [009/161] (957s left) fbdev (read) [38.604540] Starting subtest: read [38.832272] Subtest read: SUCCESS (0.228s) [38.882194] [010/161] (957s left) fbdev (write) [38.937765] Starting subtest: write [39.055437] Subtest write: SUCCESS (0.117s) [39.115305] [011/161] (956s left) gem_basic (bad-close) [39.154695] Starting subtest: bad-close [39.157886] Subtest bad-close: SUCCESS (0.000s) [39.218822] [012/161] (956s left) gem_basic (create-close) [39.261128] Starting subtest: create-close [39.264512] Subtest create-close: SUCCESS (0.000s) [39.429332] [013/161] (956s left) gem_basic (create-fd-close) [39.471219] Starting subtest: create-fd-close [39.474600] Subtest create-fd-close: SUCCESS (0.000s) [39.608132] [014/161] (956s left) gem_busy (busy@all-engines) [39.657945] Starting subtest: busy [39.659614] Starting dynamic subtest: all-engines [39.687891] Dynamic subtest all-engines: SUCCESS (0.030s) [39.689674] Subtest busy: SUCCESS (0.030s) [40.070770] [015/161] (956s left) gem_close_race (basic-process) [40.122135] Starting subtest: basic-process [40.187165] Subtest basic-process: SUCCESS (0.065s) [40.375206] [016/161] (955s left) gem_close_race (basic-threads) [40.426603] Starting subtest: basic-threads [41.687129] Subtest basic-threads: SUCCESS (1.259s) [41.933165] [017/161] (954s left) gem_ctx_create (basic) [41.980796] Starting subtest: basic [41.982620] Subtest basic: SUCCESS (0.000s) [42.221246] [018/161] (954s left) gem_ctx_create (basic-files) [42.271613] Starting subtest: basic-files [44.284426] Subtest basic-files: SUCCESS (2.013s) [44.580535] [019/161] (951s left) gem_ctx_exec (basic) [44.621567] Starting subtest: basic [44.625104] Subtest basic: SUCCESS (0.003s) [44.734390] [020/161] (951s left) gem_exec_basic (basic) [44.780290] Starting subtest: basic [44.782150] Starting dynamic subtest: rcs0-smem [44.783999] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [44.791261] Starting dynamic subtest: bcs0-smem [44.793051] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [44.799845] Starting dynamic subtest: vcs0-smem [44.801542] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [44.808088] Starting dynamic subtest: vecs0-smem [44.809840] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [44.811484] Subtest basic: SUCCESS (0.003s) [45.070690] [021/161] (951s left) gem_exec_create (basic) [45.118125] Starting subtest: basic [45.119840] Starting dynamic subtest: smem [47.162925] Dynamic subtest smem: SUCCESS (2.071s) [47.164645] Subtest basic: SUCCESS (2.071s) [47.423051] [022/161] (949s left) gem_exec_fence (basic-busy) [47.589251] Starting subtest: basic-busy [47.591066] Starting dynamic subtest: rcs0 [47.636538] Dynamic subtest rcs0: SUCCESS (0.047s) [47.646532] Starting dynamic subtest: bcs0 [47.679955] Dynamic subtest bcs0: SUCCESS (0.044s) [47.695161] Starting dynamic subtest: vcs0 [47.726953] Dynamic subtest vcs0: SUCCESS (0.046s) [47.756799] Starting dynamic subtest: vecs0 [47.770148] Dynamic subtest vecs0: SUCCESS (0.044s) [47.772026] Subtest basic-busy: SUCCESS (0.182s) [48.415293] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [48.418195] [023/161] (948s left) gem_exec_fence (basic-wait) [48.623378] Starting subtest: basic-wait [48.625389] Starting dynamic subtest: rcs0 [48.676124] Dynamic subtest rcs0: SUCCESS (0.052s) [48.687702] Starting dynamic subtest: bcs0 [48.723899] Dynamic subtest bcs0: SUCCESS (0.049s) [48.736408] Starting dynamic subtest: vcs0 [48.774943] Dynamic subtest vcs0: SUCCESS (0.050s) [48.805386] Starting dynamic subtest: vecs0 [48.825139] Dynamic subtest vecs0: SUCCESS (0.051s) [48.827176] Subtest basic-wait: SUCCESS (0.204s) [49.404611] [024/161] (947s left) gem_exec_fence (basic-await) [49.609679] Starting subtest: basic-await [49.611743] Starting dynamic subtest: rcs0 [49.696725] Dynamic subtest rcs0: SUCCESS (0.088s) [49.706982] Starting dynamic subtest: bcs0 [49.780663] Dynamic subtest bcs0: SUCCESS (0.084s) [49.790876] Starting dynamic subtest: vcs0 [49.861712] Dynamic subtest vcs0: SUCCESS (0.081s) [49.873290] Starting dynamic subtest: vecs0 [49.951251] Dynamic subtest vecs0: SUCCESS (0.090s) [49.953149] Subtest basic-await: SUCCESS (0.345s) [50.545451] [025/161] (946s left) gem_exec_fence (nb-await) [50.709020] Starting subtest: nb-await [50.710676] Starting dynamic subtest: rcs0 [50.767985] Dynamic subtest rcs0: SUCCESS (0.058s) [50.798925] Starting dynamic subtest: bcs0 [50.844519] Dynamic subtest bcs0: SUCCESS (0.076s) [50.854554] Starting dynamic subtest: vcs0 [50.903219] Dynamic subtest vcs0: SUCCESS (0.059s) [50.920793] Starting dynamic subtest: vecs0 [50.965266] Dynamic subtest vecs0: SUCCESS (0.061s) [50.968095] Subtest nb-await: SUCCESS (0.257s) [51.596129] [026/161] (945s left) gem_exec_gttfill (basic) [51.649389] Starting subtest: basic [56.969058] Subtest basic: SUCCESS (5.344s) [57.159495] [027/161] (939s left) gem_exec_parallel (engines) [57.256592] Starting subtest: engines [57.258157] Starting dynamic subtest: basic [58.878291] Dynamic subtest basic: SUCCESS (1.626s) [58.886131] Starting dynamic subtest: contexts [61.672254] Dynamic subtest contexts: SUCCESS (2.799s) [61.680068] Starting dynamic subtest: fds [63.782057] Dynamic subtest fds: SUCCESS (2.112s) [63.790138] Starting dynamic subtest: userptr [65.677214] Dynamic subtest userptr: SUCCESS (1.897s) [65.678915] Subtest engines: SUCCESS (8.435s) [65.932729] [028/161] (930s left) gem_exec_store (basic) [65.984233] Starting subtest: basic [66.060953] Subtest basic: SUCCESS (0.076s) [66.284678] [029/161] (930s left) gem_flink_basic (bad-flink) [66.324883] Starting subtest: bad-flink [66.326606] Subtest bad-flink: SUCCESS (0.000s) [66.398535] [030/161] (930s left) gem_flink_basic (bad-open) [66.441209] Starting subtest: bad-open [66.442926] Subtest bad-open: SUCCESS (0.000s) [66.509987] [031/161] (930s left) gem_flink_basic (basic) [66.552248] Starting subtest: basic [66.553810] Subtest basic: SUCCESS (0.000s) [66.668152] [032/161] (930s left) gem_flink_basic (double-flink) [66.711141] Starting subtest: double-flink [66.712924] Subtest double-flink: SUCCESS (0.000s) [66.851970] [033/161] (930s left) gem_flink_basic (flink-lifetime) [66.894542] Starting subtest: flink-lifetime [66.896497] Subtest flink-lifetime: SUCCESS (0.001s) [66.999889] [034/161] (930s left) gem_huc_copy (huc-copy) [67.046380] Starting subtest: huc-copy [67.049822] Subtest huc-copy: SKIP (0.000s) [67.235538] [035/161] (930s left) gem_linear_blits (basic) [67.344282] Starting subtest: basic [67.349117] Subtest basic: SUCCESS (0.005s) [67.540330] [036/161] (929s left) gem_mmap (basic) [67.638240] Starting subtest: basic [67.647060] Subtest basic: SUCCESS (0.000s) [67.785786] [037/161] (929s left) gem_mmap_gtt (basic) [67.829097] Starting subtest: basic [67.830833] Subtest basic: SUCCESS (0.001s) [67.918762] [038/161] (929s left) gem_render_linear_blits (basic) [67.963741] Starting subtest: basic [67.983674] Subtest basic: SUCCESS (0.020s) [68.037539] [039/161] (929s left) gem_render_tiled_blits (basic) [68.080624] Starting subtest: basic [68.107660] Subtest basic: SUCCESS (0.026s) [68.175674] [040/161] (929s left) gem_ringfill (basic-all) [68.429759] Starting subtest: basic-all [69.579078] Subtest basic-all: SUCCESS (1.150s) [69.777613] [041/161] (927s left) gem_softpin (allocator-basic) [69.821532] Starting subtest: allocator-basic [69.890688] Subtest allocator-basic: SUCCESS (0.070s) [70.010041] [042/161] (927s left) gem_softpin (allocator-basic-reserve) [70.052797] Starting subtest: allocator-basic-reserve [70.123834] Subtest allocator-basic-reserve: SUCCESS (0.071s) [70.261629] [043/161] (927s left) gem_softpin (safe-alignment) [70.306860] Starting subtest: safe-alignment [70.315252] Subtest safe-alignment: SUCCESS (0.008s) [70.484721] [044/161] (927s left) gem_sync (basic-all) [70.540194] Starting subtest: basic-all [72.679445] Subtest basic-all: SUCCESS (2.145s) [72.874237] [045/161] (924s left) gem_sync (basic-each) [72.929658] Starting subtest: basic-each [75.029959] Subtest basic-each: SUCCESS (2.107s) [75.285869] [046/161] (922s left) gem_tiled_blits (basic) [75.384538] Starting subtest: basic [75.398730] Subtest basic: SUCCESS (0.014s) [75.608307] [047/161] (922s left) gem_tiled_fence_blits (basic) [75.768908] Starting subtest: basic [75.777157] Subtest basic: SUCCESS (0.008s) [75.950093] [048/161] (921s left) gem_tiled_pread_basic [76.241743] [049/161] (921s left) gem_wait (busy@all-engines) [76.299341] Starting subtest: busy [76.300953] Starting dynamic subtest: all-engines [76.823145] Dynamic subtest all-engines: SUCCESS (0.523s) [76.824854] Subtest busy: SUCCESS (0.524s) [77.039616] [050/161] (920s left) gem_wait (wait@all-engines) [77.093215] Starting subtest: wait [77.094876] Starting dynamic subtest: all-engines [78.143978] Dynamic subtest all-engines: SUCCESS (1.050s) [78.146910] Subtest wait: SUCCESS (1.050s) [78.346792] [051/161] (919s left) i915_getparams_basic (basic-eu-total) [78.387550] Starting subtest: basic-eu-total [78.390893] Subtest basic-eu-total: SUCCESS (0.000s) [78.493505] [052/161] (919s left) i915_getparams_basic (basic-subslice-total) [78.539012] Starting subtest: basic-subslice-total [78.542319] Subtest basic-subslice-total: SUCCESS (0.000s) [78.648212] [053/161] (919s left) i915_hangman (error-state-basic) [78.696289] Starting subtest: error-state-basic [78.701471] Subtest error-state-basic: SUCCESS (0.005s) [78.839356] [054/161] (919s left) i915_pciid [78.956106] [055/161] (919s left) kms_addfb_basic (addfb25-4-tiled) [79.071054] Starting subtest: addfb25-4-tiled [79.072452] Subtest addfb25-4-tiled: SUCCESS (0.000s) [79.182456] [056/161] (919s left) kms_addfb_basic (addfb25-bad-modifier) [79.290726] Starting subtest: addfb25-bad-modifier [79.292606] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [79.466639] [057/161] (918s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [79.573974] Starting subtest: addfb25-framebuffer-vs-set-tiling [79.575607] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [79.702755] [058/161] (918s left) kms_addfb_basic (addfb25-modifier-no-flag) [79.814912] Starting subtest: addfb25-modifier-no-flag [79.816560] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [79.975361] [059/161] (918s left) kms_addfb_basic (addfb25-x-tiled-legacy) [80.083908] Starting subtest: addfb25-x-tiled-legacy [80.085495] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [80.213287] [060/161] (918s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [80.334995] Starting subtest: addfb25-x-tiled-mismatch-legacy [80.336666] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [80.466314] [061/161] (918s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [80.578889] Starting subtest: addfb25-yf-tiled-legacy [80.580342] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [80.746811] [062/161] (917s left) kms_addfb_basic (addfb25-y-tiled-legacy) [80.871241] Starting subtest: addfb25-y-tiled-legacy [80.872976] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [81.000154] [063/161] (917s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [81.106912] Starting subtest: addfb25-y-tiled-small-legacy [81.108311] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [81.249623] [064/161] (917s left) kms_addfb_basic (bad-pitch-0) [81.290486] Starting subtest: bad-pitch-0 [81.291915] Subtest bad-pitch-0: SUCCESS (0.000s) [81.499248] [065/161] (917s left) kms_addfb_basic (bad-pitch-1024) [81.539578] Starting subtest: bad-pitch-1024 [81.540994] Subtest bad-pitch-1024: SUCCESS (0.000s) [81.745790] [066/161] (917s left) kms_addfb_basic (bad-pitch-128) [81.787494] Starting subtest: bad-pitch-128 [81.789331] Subtest bad-pitch-128: SUCCESS (0.000s) [82.006573] [067/161] (917s left) kms_addfb_basic (bad-pitch-256) [82.049697] Starting subtest: bad-pitch-256 [82.051264] Subtest bad-pitch-256: SUCCESS (0.000s) [82.268814] [068/161] (916s left) kms_addfb_basic (bad-pitch-32) [82.310274] Starting subtest: bad-pitch-32 [82.311859] Subtest bad-pitch-32: SUCCESS (0.000s) [82.566209] [069/161] (916s left) kms_addfb_basic (bad-pitch-63) [82.607831] Starting subtest: bad-pitch-63 [82.609384] Subtest bad-pitch-63: SUCCESS (0.000s) [82.850544] [070/161] (916s left) kms_addfb_basic (bad-pitch-65536) [82.891106] Starting subtest: bad-pitch-65536 [82.892776] Subtest bad-pitch-65536: SUCCESS (0.000s) [83.101616] [071/161] (916s left) kms_addfb_basic (bad-pitch-999) [83.142195] Starting subtest: bad-pitch-999 [83.143649] Subtest bad-pitch-999: SUCCESS (0.000s) [83.345572] [072/161] (916s left) kms_addfb_basic (basic) [83.386125] Starting subtest: basic [83.387702] Subtest basic: SUCCESS (0.000s) [83.599780] [073/161] (915s left) kms_addfb_basic (basic-x-tiled-legacy) [83.642201] Starting subtest: basic-x-tiled-legacy [83.643780] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [83.845018] [074/161] (915s left) kms_addfb_basic (basic-y-tiled-legacy) [83.888293] Starting subtest: basic-y-tiled-legacy [83.889863] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [84.099595] [075/161] (915s left) kms_addfb_basic (bo-too-small) [84.208906] Starting subtest: bo-too-small [84.210526] Subtest bo-too-small: SUCCESS (0.000s) [84.382089] [076/161] (915s left) kms_addfb_basic (bo-too-small-due-to-tiling) [84.492864] Starting subtest: bo-too-small-due-to-tiling [84.494516] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [84.625457] [077/161] (915s left) kms_addfb_basic (clobberred-modifier) [84.667180] Starting subtest: clobberred-modifier [84.668781] Subtest clobberred-modifier: SUCCESS (0.000s) [84.828935] [078/161] (914s left) kms_addfb_basic (framebuffer-vs-set-tiling) [84.870668] Starting subtest: framebuffer-vs-set-tiling [84.872119] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [85.082934] [079/161] (914s left) kms_addfb_basic (invalid-get-prop) [85.127119] Starting subtest: invalid-get-prop [85.128967] Subtest invalid-get-prop: SUCCESS (0.000s) [85.325896] [080/161] (914s left) kms_addfb_basic (invalid-get-prop-any) [85.367236] Starting subtest: invalid-get-prop-any [85.368688] Subtest invalid-get-prop-any: SUCCESS (0.000s) [85.526661] [081/161] (914s left) kms_addfb_basic (invalid-set-prop) [85.568975] Starting subtest: invalid-set-prop [85.570585] Subtest invalid-set-prop: SUCCESS (0.000s) [85.816221] [082/161] (914s left) kms_addfb_basic (invalid-set-prop-any) [85.857542] Starting subtest: invalid-set-prop-any [85.859070] Subtest invalid-set-prop-any: SUCCESS (0.000s) [86.050619] [083/161] (914s left) kms_addfb_basic (no-handle) [86.092963] Starting subtest: no-handle [86.094630] Subtest no-handle: SUCCESS (0.000s) [86.265377] [084/161] (913s left) kms_addfb_basic (size-max) [86.372844] Starting subtest: size-max [86.374385] Subtest size-max: SUCCESS (0.000s) [86.511531] [085/161] (913s left) kms_addfb_basic (small-bo) [86.620912] Starting subtest: small-bo [86.622532] Subtest small-bo: SUCCESS (0.000s) [86.800620] [086/161] (913s left) kms_addfb_basic (tile-pitch-mismatch) [86.843196] Starting subtest: tile-pitch-mismatch [86.844661] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [87.040335] [087/161] (913s left) kms_addfb_basic (too-high) [87.148797] Starting subtest: too-high [87.150368] Subtest too-high: SUCCESS (0.000s) [87.258643] [088/161] (913s left) kms_addfb_basic (too-wide) [87.368757] Starting subtest: too-wide [87.370319] Subtest too-wide: SUCCESS (0.000s) [87.520399] [089/161] (912s left) kms_addfb_basic (unused-handle) [87.562723] Starting subtest: unused-handle [87.564234] Subtest unused-handle: SUCCESS (0.000s) [87.742085] [090/161] (912s left) kms_addfb_basic (unused-modifier) [87.784779] Starting subtest: unused-modifier [87.786293] Subtest unused-modifier: SUCCESS (0.000s) [88.015343] [091/161] (912s left) kms_addfb_basic (unused-offsets) [88.056476] Starting subtest: unused-offsets [88.057990] Subtest unused-offsets: SUCCESS (0.000s) [88.262662] [092/161] (912s left) kms_addfb_basic (unused-pitches) [88.304808] Starting subtest: unused-pitches [88.306669] Subtest unused-pitches: SUCCESS (0.000s) [88.470346] [093/161] (912s left) kms_busy (basic) [88.579743] Starting subtest: basic [88.581269] Starting dynamic subtest: flip [89.060522] Dynamic subtest flip: SUCCESS (0.477s) [89.068928] Starting dynamic subtest: modeset [89.474480] Dynamic subtest modeset: SUCCESS (0.416s) [89.476169] Subtest basic: SUCCESS (0.895s) [89.603265] [094/161] (911s left) kms_prop_blob (basic) [89.646717] Starting subtest: basic [89.648210] Subtest basic: SUCCESS (0.000s) [89.724040] [095/161] (911s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [89.831299] Starting subtest: basic-busy-flip-before-cursor-atomic [89.834541] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [89.926212] [096/161] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [90.036168] Starting subtest: basic-busy-flip-before-cursor-legacy [90.039488] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [90.149230] [097/161] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [90.257112] Starting subtest: basic-flip-after-cursor-atomic [91.157547] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.899s) [91.287662] [098/161] (909s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [91.397144] Starting subtest: basic-flip-after-cursor-legacy [92.304606] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.906s) [92.431742] [099/161] (908s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [92.539032] Starting subtest: basic-flip-after-cursor-varying-size [93.434476] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.894s) [93.585831] [100/161] (907s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [93.694056] Starting subtest: basic-flip-before-cursor-atomic [94.602670] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.907s) [94.772282] [101/161] (906s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [94.883953] Starting subtest: basic-flip-before-cursor-legacy [95.787257] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.902s) [95.934768] [102/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [96.040938] Starting subtest: basic-flip-before-cursor-varying-size [96.934749] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.892s) [97.081652] [103/161] (904s left) kms_dsc (dsc-basic) [97.190954] Subtest dsc-basic: SKIP (0.000s) [97.228957] [104/161] (903s left) kms_flip (basic-flip-vs-dpms) [97.340046] Starting subtest: basic-flip-vs-dpms [97.341651] Starting dynamic subtest: A-HDMI-A1 [98.186583] Dynamic subtest A-HDMI-A1: SUCCESS (0.844s) [98.195159] Starting dynamic subtest: B-HDMI-A1 [98.996433] Dynamic subtest B-HDMI-A1: SUCCESS (0.811s) [99.005234] Starting dynamic subtest: C-HDMI-A1 [99.809693] Dynamic subtest C-HDMI-A1: SUCCESS (0.812s) [99.811209] Subtest basic-flip-vs-dpms: SUCCESS (2.472s) [99.934513] [105/161] (901s left) kms_flip (basic-flip-vs-modeset) [100.056175] Starting subtest: basic-flip-vs-modeset [100.057779] Starting dynamic subtest: A-HDMI-A1 [100.885747] Dynamic subtest A-HDMI-A1: SUCCESS (0.829s) [100.894161] Starting dynamic subtest: B-HDMI-A1 [101.670646] Dynamic subtest B-HDMI-A1: SUCCESS (0.784s) [101.678868] Starting dynamic subtest: C-HDMI-A1 [102.468545] Dynamic subtest C-HDMI-A1: SUCCESS (0.797s) [102.470057] Subtest basic-flip-vs-modeset: SUCCESS (2.414s) [102.617366] [106/161] (898s left) kms_flip (basic-flip-vs-wf_vblank) [102.734305] Starting subtest: basic-flip-vs-wf_vblank [102.735933] Starting dynamic subtest: A-HDMI-A1 [103.825223] Dynamic subtest A-HDMI-A1: SUCCESS (1.089s) [103.834543] Starting dynamic subtest: B-HDMI-A1 [104.911739] Dynamic subtest B-HDMI-A1: SUCCESS (1.085s) [104.920745] Starting dynamic subtest: C-HDMI-A1 [105.999231] Dynamic subtest C-HDMI-A1: SUCCESS (1.086s) [106.002708] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.268s) [106.139357] [107/161] (895s left) kms_flip (basic-plain-flip) [106.247145] Starting subtest: basic-plain-flip [106.248655] Starting dynamic subtest: A-HDMI-A1 [107.057648] Dynamic subtest A-HDMI-A1: SUCCESS (0.810s) [107.066381] Starting dynamic subtest: B-HDMI-A1 [107.863935] Dynamic subtest B-HDMI-A1: SUCCESS (0.805s) [107.872899] Starting dynamic subtest: C-HDMI-A1 [108.667799] Dynamic subtest C-HDMI-A1: SUCCESS (0.803s) [108.671699] Subtest basic-plain-flip: SUCCESS (2.424s) [108.816677] [108/161] (892s left) kms_force_connector_basic (force-connector-state) [108.961615] Starting subtest: force-connector-state [109.276356] Subtest force-connector-state: SUCCESS (0.314s) [109.666948] [109/161] (891s left) kms_force_connector_basic (force-edid) [109.807547] Starting subtest: force-edid [109.942467] Subtest force-edid: SUCCESS (0.135s) [110.138897] [110/161] (891s left) kms_force_connector_basic (force-load-detect) [110.279625] Starting subtest: force-load-detect [110.282350] Subtest force-load-detect: SKIP (0.000s) [110.477443] [111/161] (891s left) kms_force_connector_basic (prune-stale-modes) [110.619297] Starting subtest: prune-stale-modes [110.754972] Subtest prune-stale-modes: SUCCESS (0.137s) [110.970349] [112/161] (890s left) kms_frontbuffer_tracking (basic) [111.088744] Starting subtest: basic [113.618162] Subtest basic: SUCCESS (2.534s) [113.783041] [113/161] (887s left) kms_hdmi_inject (inject-audio) [113.839867] Starting subtest: inject-audio [113.954400] Subtest inject-audio: SUCCESS (0.114s) [114.115676] [114/161] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [114.224166] Starting subtest: compare-crc-sanitycheck-xr24 [114.225671] Starting dynamic subtest: pipe-A-HDMI-A-1 [114.579409] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.352s) [114.588224] Starting dynamic subtest: pipe-B-HDMI-A-1 [114.899467] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.318s) [114.909214] Starting dynamic subtest: pipe-C-HDMI-A-1 [115.223813] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.322s) [115.225394] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.998s) [115.382032] [115/161] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [115.491134] Starting subtest: compare-crc-sanitycheck-nv12 [115.492744] Starting dynamic subtest: pipe-A-HDMI-A-1 [115.927236] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.433s) [115.937140] Starting dynamic subtest: pipe-B-HDMI-A-1 [116.284456] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.355s) [116.294868] Starting dynamic subtest: pipe-C-HDMI-A-1 [116.298182] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [116.299740] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.794s) [116.431992] [116/161] (885s left) kms_pipe_crc_basic (hang-read-crc) [116.543127] Starting subtest: hang-read-crc [116.544714] Starting dynamic subtest: pipe-A-HDMI-A-1 [117.453766] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.909s) [117.467403] Starting dynamic subtest: pipe-B-HDMI-A-1 [118.268722] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.812s) [118.277183] Starting dynamic subtest: pipe-C-HDMI-A-1 [119.168037] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.897s) [119.169477] Subtest hang-read-crc: SUCCESS (2.624s) [119.277160] [117/161] (882s left) kms_pipe_crc_basic (nonblocking-crc) [119.387223] Starting subtest: nonblocking-crc [119.388847] Starting dynamic subtest: pipe-A-HDMI-A-1 [119.909080] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.519s) [119.917995] Starting dynamic subtest: pipe-B-HDMI-A-1 [120.387339] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.478s) [120.397337] Starting dynamic subtest: pipe-C-HDMI-A-1 [120.836901] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.447s) [120.838549] Subtest nonblocking-crc: SUCCESS (1.450s) [120.950701] [118/161] (880s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [121.061125] Starting subtest: nonblocking-crc-frame-sequence [121.062770] Starting dynamic subtest: pipe-A-HDMI-A-1 [121.611028] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.548s) [121.621600] Starting dynamic subtest: pipe-B-HDMI-A-1 [122.094265] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.481s) [122.103871] Starting dynamic subtest: pipe-C-HDMI-A-1 [122.543925] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.448s) [122.545517] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.483s) [122.651811] [119/161] (879s left) kms_pipe_crc_basic (read-crc) [122.763319] Starting subtest: read-crc [122.764996] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.286241] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.521s) [123.298249] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.721232] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.431s) [123.730527] Starting dynamic subtest: pipe-C-HDMI-A-1 [124.152209] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.431s) [124.153829] Subtest read-crc: SUCCESS (1.388s) [124.268533] [120/161] (877s left) kms_pipe_crc_basic (read-crc-frame-sequence) [124.378118] Starting subtest: read-crc-frame-sequence [124.379656] Starting dynamic subtest: pipe-A-HDMI-A-1 [124.845746] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.466s) [124.854265] Starting dynamic subtest: pipe-B-HDMI-A-1 [125.292341] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.446s) [125.302301] Starting dynamic subtest: pipe-C-HDMI-A-1 [125.710064] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.416s) [125.711747] Subtest read-crc-frame-sequence: SUCCESS (1.332s) [125.823110] [121/161] (876s left) kms_pm_backlight (basic-brightness) [125.934211] Subtest basic-brightness: SKIP (0.000s) [125.976727] [122/161] (876s left) kms_pm_rpm (basic-pci-d3-state) [127.411467] Starting subtest: basic-pci-d3-state [127.725706] Subtest basic-pci-d3-state: SUCCESS (0.320s) [127.907134] [123/161] (874s left) kms_pm_rpm (basic-rte) [127.948608] Starting subtest: basic-rte [129.579361] Subtest basic-rte: SUCCESS (1.631s) [130.092717] [124/161] (872s left) kms_psr (psr-primary-page-flip) [130.204107] Subtest psr-primary-page-flip: SKIP (0.000s) [130.248672] [125/161] (871s left) kms_psr (psr-cursor-plane-move) [130.359131] Subtest psr-cursor-plane-move: SKIP (0.000s) [130.398919] [126/161] (871s left) kms_psr (psr-sprite-plane-onoff) [130.507075] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [130.587403] [127/161] (871s left) kms_psr (psr-primary-mmap-gtt) [130.698140] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [130.748992] [128/161] (871s left) kms_setmode (basic-clone-single-crtc) [130.790561] Starting subtest: basic-clone-single-crtc [130.795254] Subtest basic-clone-single-crtc: SKIP (0.000s) [130.883771] [129/161] (871s left) i915_pm_rps (basic-api) [130.928013] Starting subtest: basic-api [130.931354] Subtest basic-api: SUCCESS (0.002s) [131.005747] [130/161] (871s left) prime_self_import (basic-llseek-bad) [131.047336] Starting subtest: basic-llseek-bad [131.050552] Subtest basic-llseek-bad: SUCCESS (0.002s) [131.156170] [131/161] (871s left) prime_self_import (basic-llseek-size) [131.199476] Starting subtest: basic-llseek-size [131.202504] Subtest basic-llseek-size: SUCCESS (0.003s) [131.323546] [132/161] (871s left) prime_self_import (basic-with_fd_dup) [131.364389] Starting subtest: basic-with_fd_dup [131.367583] Subtest basic-with_fd_dup: SUCCESS (0.002s) [131.516413] [133/161] (871s left) prime_self_import (basic-with_one_bo) [131.557114] Starting subtest: basic-with_one_bo [131.560198] Subtest basic-with_one_bo: SUCCESS (0.002s) [131.637628] [134/161] (870s left) prime_self_import (basic-with_one_bo_two_files) [131.679043] Starting subtest: basic-with_one_bo_two_files [131.682665] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [131.865697] [135/161] (870s left) prime_self_import (basic-with_two_bos) [131.907757] Starting subtest: basic-with_two_bos [131.910880] Subtest basic-with_two_bos: SUCCESS (0.002s) [132.081746] [136/161] (870s left) prime_vgem (basic-fence-flip) [132.138518] Starting subtest: basic-fence-flip [132.534514] Subtest basic-fence-flip: SUCCESS (0.396s) [132.699608] [137/161] (870s left) prime_vgem (basic-fence-mmap) [132.756123] Starting subtest: basic-fence-mmap [132.774415] Subtest basic-fence-mmap: SUCCESS (0.019s) [132.946421] [138/161] (869s left) prime_vgem (basic-fence-read) [133.006577] Starting subtest: basic-fence-read [133.047418] Subtest basic-fence-read: SUCCESS (0.041s) [133.216219] [139/161] (869s left) prime_vgem (basic-gtt) [133.272466] Starting subtest: basic-gtt [133.279864] Subtest basic-gtt: SUCCESS (0.008s) [133.446151] [140/161] (869s left) prime_vgem (basic-read) [133.514548] Starting subtest: basic-read [133.533282] Subtest basic-read: SUCCESS (0.019s) [133.711567] [141/161] (869s left) prime_vgem (basic-write) [133.756620] Starting subtest: basic-write [133.773462] Subtest basic-write: SUCCESS (0.018s) [133.896077] [142/161] (869s left) vgem_basic (setversion) [133.952299] Starting subtest: setversion [133.955579] Subtest setversion: SUCCESS (0.000s) [134.046786] [143/161] (869s left) vgem_basic (create) [134.102360] Starting subtest: create [134.104247] Subtest create: SUCCESS (0.000s) [134.227032] [144/161] (869s left) vgem_basic (debugfs) [134.270166] Starting subtest: debugfs [134.271991] Subtest debugfs: SUCCESS (0.000s) [134.352771] [145/161] (869s left) vgem_basic (dmabuf-export) [134.402538] Starting subtest: dmabuf-export [134.419478] Subtest dmabuf-export: SUCCESS (0.018s) [134.596622] [146/161] (868s left) vgem_basic (dmabuf-fence) [134.656219] Starting subtest: dmabuf-fence [134.659160] Subtest dmabuf-fence: SUCCESS (0.002s) [134.751189] [147/161] (868s left) vgem_basic (dmabuf-fence-before) [134.802291] Starting subtest: dmabuf-fence-before [134.804169] Subtest dmabuf-fence-before: SUCCESS (0.000s) [134.914409] [148/161] (868s left) vgem_basic (dmabuf-mmap) [134.969303] Starting subtest: dmabuf-mmap [134.976606] Subtest dmabuf-mmap: SUCCESS (0.008s) [135.035842] [149/161] (868s left) vgem_basic (mmap) [135.085576] Starting subtest: mmap [135.089979] Subtest mmap: SUCCESS (0.005s) [135.171845] [150/161] (868s left) vgem_basic (second-client) [135.219203] Starting subtest: second-client [135.252712] Subtest second-client: SUCCESS (0.033s) [135.362659] [151/161] (868s left) vgem_basic (sysfs) [135.419771] Starting subtest: sysfs [135.421680] Subtest sysfs: SUCCESS (0.000s) [135.527705] [152/161] (868s left) core_hotunplug (unbind-rebind) [135.619877] Starting subtest: unbind-rebind [139.792815] Subtest unbind-rebind: SUCCESS (4.174s) [139.828127] [153/161] (864s left) vgem_basic (unload) [139.870897] Starting subtest: unload [169.012091] Subtest unload: SUCCESS (29.143s) [169.111370] [154/161] (834s left) i915_module_load (reload) [169.153199] Starting subtest: reload [172.379562] Subtest reload: SUCCESS (3.228s) [172.422199] [155/161] (831s left) gem_lmem_swapping (basic) [172.480803] Subtest basic: SKIP (0.000s) [172.527480] [156/161] (831s left) gem_lmem_swapping (parallel-random-engines) [172.589250] Subtest parallel-random-engines: SKIP (0.000s) [172.655672] [157/161] (831s left) gem_lmem_swapping (random-engines) [172.701308] Subtest random-engines: SKIP (0.000s) [172.744259] [158/161] (831s left) gem_lmem_swapping (verify-random) [172.790271] Subtest verify-random: SKIP (0.000s) [172.825991] [159/161] (831s left) i915_pm_rpm (module-reload) [174.332621] Starting subtest: module-reload [183.891291] Subtest module-reload: SUCCESS (9.560s) [183.916730] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [183.917634] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [183.920377] [160/161] (820s left) i915_selftest (live) [183.965660] Starting subtest: live [183.967215] Starting dynamic subtest: sanitycheck [186.209284] Dynamic subtest sanitycheck: SUCCESS (2.243s) [186.218743] Starting dynamic subtest: uncore [188.385532] Dynamic subtest uncore: SUCCESS (2.175s) [188.394157] Starting dynamic subtest: workarounds [190.852258] Dynamic subtest workarounds: SUCCESS (2.466s) [190.861198] Starting dynamic subtest: gt_engines [193.490269] Dynamic subtest gt_engines: SUCCESS (2.637s) [193.499641] Starting dynamic subtest: gt_timelines [200.957359] Dynamic subtest gt_timelines: SUCCESS (7.466s) [200.966947] Starting dynamic subtest: gt_contexts [203.379423] Dynamic subtest gt_contexts: SUCCESS (2.421s) [203.392021] Starting dynamic subtest: gt_lrc [207.966355] Dynamic subtest gt_lrc: SUCCESS (4.586s) [207.975151] Starting dynamic subtest: gt_mocs [210.310345] Dynamic subtest gt_mocs: SUCCESS (2.343s) [210.319985] Starting dynamic subtest: gt_pm [216.926228] Dynamic subtest gt_pm: SUCCESS (6.615s) [216.935495] Starting dynamic subtest: gt_heartbeat [219.188380] Dynamic subtest gt_heartbeat: SUCCESS (2.261s) [219.197845] Starting dynamic subtest: gt_tlb [222.208345] Dynamic subtest gt_tlb: SUCCESS (3.019s) [222.217767] Starting dynamic subtest: requests [230.778259] Dynamic subtest requests: SUCCESS (8.569s) [230.786904] Starting dynamic subtest: migrate [236.582343] Dynamic subtest migrate: SUCCESS (5.803s) [236.591457] Starting dynamic subtest: active [238.853786] Dynamic subtest active: SUCCESS (2.270s) [238.863399] Starting dynamic subtest: objects [241.530401] Dynamic subtest objects: SUCCESS (2.675s) [241.540155] Starting dynamic subtest: mman [246.877413] Dynamic subtest mman: SUCCESS (5.346s) [246.886879] Starting dynamic subtest: dmabuf [249.242636] Dynamic subtest dmabuf: SUCCESS (2.364s) [249.252074] Starting dynamic subtest: vma [251.518432] Dynamic subtest vma: SUCCESS (2.275s) [251.527932] Starting dynamic subtest: coherency [254.304299] Dynamic subtest coherency: SUCCESS (2.785s) [254.313175] Starting dynamic subtest: gtt [263.583708] Dynamic subtest gtt: SUCCESS (9.278s) [263.593926] Starting dynamic subtest: gem [266.083325] Dynamic subtest gem: SUCCESS (2.498s) [266.092202] Starting dynamic subtest: evict [269.138465] Dynamic subtest evict: SUCCESS (3.054s) [269.147172] Starting dynamic subtest: hugepages [277.399862] Dynamic subtest hugepages: SUCCESS (8.260s) [277.410210] Starting dynamic subtest: gem_contexts [291.594751] Dynamic subtest gem_contexts: SUCCESS (14.194s) [291.603056] Starting dynamic subtest: client [293.924118] Dynamic subtest client: SUCCESS (2.328s) [293.933141] Starting dynamic subtest: gem_migrate [296.151225] Dynamic subtest gem_migrate: SUCCESS (2.226s) [296.160274] Starting dynamic subtest: reset [298.586337] Dynamic subtest reset: SUCCESS (2.434s) [298.595598] Starting dynamic subtest: memory_region [300.825350] Dynamic subtest memory_region: SUCCESS (2.238s) [300.834752] Starting dynamic subtest: hangcheck [326.405684] Dynamic subtest hangcheck: SUCCESS (25.579s) [326.417128] Starting dynamic subtest: execlists [337.040777] Dynamic subtest execlists: SUCCESS (10.634s) [337.048952] Starting dynamic subtest: ring_submission [339.249124] Dynamic subtest ring_submission: SUCCESS (2.207s) [339.257367] Starting dynamic subtest: perf [341.605191] Dynamic subtest perf: SUCCESS (2.355s) [341.613771] Starting dynamic subtest: slpc [343.822586] Dynamic subtest slpc: SUCCESS (2.216s) [343.832064] Starting dynamic subtest: guc [346.056479] Dynamic subtest guc: SUCCESS (2.233s) [346.066143] Starting dynamic subtest: guc_multi_lrc [348.403370] Dynamic subtest guc_multi_lrc: SUCCESS (2.345s) [348.410879] Starting dynamic subtest: guc_hang [350.630350] Dynamic subtest guc_hang: SUCCESS (2.226s) [350.641571] Starting dynamic subtest: late_gt_pm [353.003059] Dynamic subtest late_gt_pm: SUCCESS (2.372s) [353.004644] Subtest live: SUCCESS (169.041s) [353.036704] [161/161] (651s left) dmabuf (all-tests) [353.084245] Starting subtest: all-tests [353.085625] Starting dynamic subtest: sanitycheck [353.207120] Dynamic subtest sanitycheck: SUCCESS (0.121s) [353.227603] Starting dynamic subtest: dma_fence [353.509334] Dynamic subtest dma_fence: SUCCESS (0.298s) [353.545606] Starting dynamic subtest: dma_fence_chain [363.004144] Dynamic subtest dma_fence_chain: SUCCESS (9.488s) [363.020744] Starting dynamic subtest: dma_fence_unwrap [363.133055] Dynamic subtest dma_fence_unwrap: SUCCESS (0.124s) [363.153844] Starting dynamic subtest: dma_resv [363.281081] Dynamic subtest dma_resv: SUCCESS (0.143s) [363.283622] Subtest all-tests: SUCCESS (10.198s) [363.332600] Closing watchdogs Done.