[36.373981] Initializing watchdogs [36.374116] /dev/watchdog0 [36.386841] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5912 Intel Kabylake (Gen9) HD Graphics 630 [36.393184] [001/161] (960s left) i915_module_load (load) [36.651832] Starting subtest: load [36.653458] Subtest load: SKIP (0.001s) [36.673369] [002/161] (960s left) core_auth (basic-auth) [40.518084] Starting subtest: basic-auth [40.519336] Subtest basic-auth: SUCCESS (0.001s) [40.547062] [FACT core_auth (basic-auth)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [40.548359] [FACT core_auth (basic-auth)] new: kernel.kmod_is_loaded.amdgpu: true [40.548499] [FACT core_auth (basic-auth)] new: kernel.kmod_is_loaded.i915: true [40.549465] [FACT core_auth (basic-auth)] new: kernel.kmod_is_loaded.xe: true [40.551014] [003/161] (956s left) debugfs_test (read_all_entries) [40.611596] Starting subtest: read_all_entries [40.753665] Subtest read_all_entries: SUCCESS (0.143s) [40.816214] [004/161] (956s left) debugfs_test (basic-hwmon) [40.866610] Starting subtest: basic-hwmon [40.867472] Subtest basic-hwmon: SKIP (0.000s) [40.932508] [005/161] (956s left) debugfs_test (sysfs) [40.980998] Starting subtest: sysfs [41.014666] Subtest sysfs: SUCCESS (0.034s) [41.074828] [006/161] (955s left) fbdev (eof) [41.131410] Subtest eof: SKIP (0.000s) [41.159521] [007/161] (955s left) fbdev (info) [41.213523] Subtest info: SKIP (0.000s) [41.242481] [008/161] (955s left) fbdev (nullptr) [41.296931] Subtest nullptr: SKIP (0.000s) [41.326225] [009/161] (955s left) fbdev (read) [41.381618] Subtest read: SKIP (0.000s) [41.410941] [010/161] (955s left) fbdev (write) [41.466909] Subtest write: SKIP (0.000s) [41.495790] [011/161] (955s left) gem_basic (bad-close) [41.542233] Starting subtest: bad-close [41.542998] Subtest bad-close: SUCCESS (0.000s) [41.571336] [012/161] (955s left) gem_basic (create-close) [41.618591] Starting subtest: create-close [41.623386] Subtest create-close: SUCCESS (0.000s) [41.668999] [013/161] (955s left) gem_basic (create-fd-close) [41.716658] Starting subtest: create-fd-close [41.717491] Subtest create-fd-close: SUCCESS (0.000s) [41.777894] [014/161] (955s left) gem_busy (busy@all-engines) [41.839369] Starting subtest: busy [41.839898] Starting dynamic subtest: all-engines [41.877888] Dynamic subtest all-engines: SUCCESS (0.038s) [41.878401] Subtest busy: SUCCESS (0.039s) [42.304742] [015/161] (955s left) gem_close_race (basic-process) [42.370479] Starting subtest: basic-process [42.445076] Subtest basic-process: SUCCESS (0.075s) [42.627401] [016/161] (954s left) gem_close_race (basic-threads) [42.693158] Starting subtest: basic-threads [43.917945] Subtest basic-threads: SUCCESS (1.231s) [44.105145] [017/161] (953s left) gem_ctx_create (basic) [44.162988] Starting subtest: basic [44.163453] Subtest basic: SUCCESS (0.000s) [44.366183] [018/161] (953s left) gem_ctx_create (basic-files) [44.422936] Starting subtest: basic-files [46.438018] Subtest basic-files: SUCCESS (2.071s) [46.725172] [019/161] (950s left) gem_ctx_exec (basic) [46.771483] Starting subtest: basic [46.775555] Subtest basic: SUCCESS (0.004s) [46.844767] [020/161] (950s left) gem_exec_basic (basic) [46.899193] Starting subtest: basic [46.900369] Starting dynamic subtest: rcs0-smem [46.901577] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [46.907520] Starting dynamic subtest: bcs0-smem [46.907959] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [46.913666] Starting dynamic subtest: vcs0-smem [46.914059] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [46.919702] Starting dynamic subtest: vecs0-smem [46.920095] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [46.920451] Subtest basic: SUCCESS (0.005s) [47.150062] [021/161] (950s left) gem_exec_create (basic) [47.206383] Starting subtest: basic [47.206920] Starting dynamic subtest: smem [49.257055] Dynamic subtest smem: SUCCESS (2.090s) [49.257565] Subtest basic: SUCCESS (2.090s) [49.431443] [022/161] (948s left) gem_exec_fence (basic-busy) [49.655287] Starting subtest: basic-busy [49.656458] Starting dynamic subtest: rcs0 [49.709139] Dynamic subtest rcs0: SUCCESS (0.055s) [49.724196] Starting dynamic subtest: bcs0 [49.761223] Dynamic subtest bcs0: SUCCESS (0.051s) [49.790917] Starting dynamic subtest: vcs0 [49.810193] Dynamic subtest vcs0: SUCCESS (0.050s) [49.826173] Starting dynamic subtest: vecs0 [49.851908] Dynamic subtest vecs0: SUCCESS (0.041s) [49.852904] Subtest basic-busy: SUCCESS (0.200s) [50.459200] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [50.461935] [023/161] (947s left) gem_exec_fence (basic-wait) [50.679949] Starting subtest: basic-wait [50.680829] Starting dynamic subtest: rcs0 [50.717919] Dynamic subtest rcs0: SUCCESS (0.039s) [50.724708] Starting dynamic subtest: bcs0 [50.757224] Dynamic subtest bcs0: SUCCESS (0.039s) [50.766762] Starting dynamic subtest: vcs0 [50.799452] Dynamic subtest vcs0: SUCCESS (0.041s) [50.826136] Starting dynamic subtest: vecs0 [50.840135] Dynamic subtest vecs0: SUCCESS (0.042s) [50.841047] Subtest basic-wait: SUCCESS (0.163s) [51.399793] [024/161] (946s left) gem_exec_fence (basic-await) [51.623775] Starting subtest: basic-await [51.625236] Starting dynamic subtest: rcs0 [51.719701] Dynamic subtest rcs0: SUCCESS (0.095s) [51.728457] Starting dynamic subtest: bcs0 [51.809940] Dynamic subtest bcs0: SUCCESS (0.092s) [51.821476] Starting dynamic subtest: vcs0 [51.905685] Dynamic subtest vcs0: SUCCESS (0.096s) [51.916545] Starting dynamic subtest: vecs0 [51.998676] Dynamic subtest vecs0: SUCCESS (0.094s) [51.999624] Subtest basic-await: SUCCESS (0.379s) [52.658609] [025/161] (945s left) gem_exec_fence (nb-await) [52.849149] Starting subtest: nb-await [52.850327] Starting dynamic subtest: rcs0 [52.910055] Dynamic subtest rcs0: SUCCESS (0.061s) [52.932602] Starting dynamic subtest: bcs0 [52.984401] Dynamic subtest bcs0: SUCCESS (0.073s) [53.014353] Starting dynamic subtest: vcs0 [53.067716] Dynamic subtest vcs0: SUCCESS (0.082s) [53.097585] Starting dynamic subtest: vecs0 [53.147955] Dynamic subtest vecs0: SUCCESS (0.080s) [53.150148] Subtest nb-await: SUCCESS (0.299s) [53.793159] [026/161] (943s left) gem_exec_gttfill (basic) [53.856570] Starting subtest: basic [61.019506] Subtest basic: SUCCESS (7.201s) [61.162090] [027/161] (936s left) gem_exec_parallel (engines) [61.283814] Starting subtest: engines [61.284284] Starting dynamic subtest: basic [63.166010] Dynamic subtest basic: SUCCESS (1.884s) [63.175236] Starting dynamic subtest: contexts [67.670160] Dynamic subtest contexts: SUCCESS (4.515s) [67.677370] Starting dynamic subtest: fds [71.949932] Dynamic subtest fds: SUCCESS (4.285s) [71.958014] Starting dynamic subtest: userptr [73.957195] Dynamic subtest userptr: SUCCESS (2.008s) [73.957747] Subtest engines: SUCCESS (12.693s) [74.178925] [028/161] (923s left) gem_exec_store (basic) [74.240653] Starting subtest: basic [74.309139] Subtest basic: SUCCESS (0.068s) [74.518184] [029/161] (923s left) gem_flink_basic (bad-flink) [74.564458] Starting subtest: bad-flink [74.564871] Subtest bad-flink: SUCCESS (0.000s) [74.599122] [030/161] (923s left) gem_flink_basic (bad-open) [74.645230] Starting subtest: bad-open [74.645710] Subtest bad-open: SUCCESS (0.000s) [74.679209] [031/161] (923s left) gem_flink_basic (basic) [74.725823] Starting subtest: basic [74.726252] Subtest basic: SUCCESS (0.000s) [74.779232] [032/161] (923s left) gem_flink_basic (double-flink) [74.826461] Starting subtest: double-flink [74.826957] Subtest double-flink: SUCCESS (0.000s) [74.904172] [033/161] (923s left) gem_flink_basic (flink-lifetime) [74.953453] Starting subtest: flink-lifetime [74.953957] Subtest flink-lifetime: SUCCESS (0.001s) [75.006226] [034/161] (923s left) gem_huc_copy (huc-copy) [75.059033] Starting subtest: huc-copy [75.061062] Subtest huc-copy: SUCCESS (0.002s) [75.138087] [035/161] (922s left) gem_linear_blits (basic) [75.272845] Starting subtest: basic [75.280620] Subtest basic: SUCCESS (0.008s) [75.398676] [036/161] (922s left) gem_mmap (basic) [75.518970] Starting subtest: basic [75.521219] Subtest basic: SUCCESS (0.000s) [75.608996] [037/161] (922s left) gem_mmap_gtt (basic) [75.656917] Starting subtest: basic [75.657513] Subtest basic: SUCCESS (0.001s) [75.691722] [038/161] (922s left) gem_render_linear_blits (basic) [75.744738] Starting subtest: basic [75.773438] Subtest basic: SUCCESS (0.029s) [75.826962] [039/161] (922s left) gem_render_tiled_blits (basic) [75.877424] Starting subtest: basic [75.910137] Subtest basic: SUCCESS (0.032s) [75.957946] [040/161] (922s left) gem_ringfill (basic-all) [76.187344] Starting subtest: basic-all [77.335295] Subtest basic-all: SUCCESS (1.142s) [77.486164] [041/161] (920s left) gem_softpin (allocator-basic) [77.541844] Starting subtest: allocator-basic [77.644690] Subtest allocator-basic: SUCCESS (0.099s) [77.732821] [042/161] (920s left) gem_softpin (allocator-basic-reserve) [77.784478] Starting subtest: allocator-basic-reserve [77.885360] Subtest allocator-basic-reserve: SUCCESS (0.097s) [77.962058] [043/161] (920s left) gem_softpin (safe-alignment) [78.017227] Starting subtest: safe-alignment [78.027590] Subtest safe-alignment: SUCCESS (0.010s) [78.127201] [044/161] (920s left) gem_sync (basic-all) [78.190012] Starting subtest: basic-all [80.283938] Subtest basic-all: SUCCESS (2.093s) [80.428999] [045/161] (918s left) gem_sync (basic-each) [80.491033] Starting subtest: basic-each [82.576623] Subtest basic-each: SUCCESS (2.086s) [82.829832] [046/161] (915s left) gem_tiled_blits (basic) [82.941362] Starting subtest: basic [82.958725] Subtest basic: SUCCESS (0.018s) [83.096263] [047/161] (915s left) gem_tiled_fence_blits (basic) [83.291678] Starting subtest: basic [83.300786] Subtest basic: SUCCESS (0.009s) [83.452885] [048/161] (915s left) gem_tiled_pread_basic [83.709607] [049/161] (915s left) gem_wait (busy@all-engines) [83.778992] Starting subtest: busy [83.779518] Starting dynamic subtest: all-engines [84.305878] Dynamic subtest all-engines: SUCCESS (0.527s) [84.306355] Subtest busy: SUCCESS (0.527s) [84.468833] [050/161] (914s left) gem_wait (wait@all-engines) [84.536959] Starting subtest: wait [84.537531] Starting dynamic subtest: all-engines [85.590496] Dynamic subtest all-engines: SUCCESS (1.052s) [85.592822] Subtest wait: SUCCESS (1.053s) [85.852699] [051/161] (913s left) i915_getparams_basic (basic-eu-total) [85.900388] Starting subtest: basic-eu-total [85.901194] Subtest basic-eu-total: SUCCESS (0.000s) [85.935187] [052/161] (913s left) i915_getparams_basic (basic-subslice-total) [85.980517] Starting subtest: basic-subslice-total [85.981309] Subtest basic-subslice-total: SUCCESS (0.000s) [86.016538] [053/161] (913s left) i915_hangman (error-state-basic) [86.074734] Starting subtest: error-state-basic [86.136797] Subtest error-state-basic: SUCCESS (0.062s) [86.176948] [054/161] (912s left) i915_pciid [86.262492] [055/161] (912s left) kms_addfb_basic (addfb25-4-tiled) [86.397492] Starting subtest: addfb25-4-tiled [86.397983] Subtest addfb25-4-tiled: SUCCESS (0.000s) [86.449922] [056/161] (912s left) kms_addfb_basic (addfb25-bad-modifier) [86.580046] Starting subtest: addfb25-bad-modifier [86.580672] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [86.655147] [057/161] (912s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [86.787440] Starting subtest: addfb25-framebuffer-vs-set-tiling [86.788012] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [86.881168] [058/161] (912s left) kms_addfb_basic (addfb25-modifier-no-flag) [87.011918] Starting subtest: addfb25-modifier-no-flag [87.012543] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [87.110069] [059/161] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy) [87.238343] Starting subtest: addfb25-x-tiled-legacy [87.238821] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [87.300118] [060/161] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [87.428019] Starting subtest: addfb25-x-tiled-mismatch-legacy [87.428542] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [87.483028] [061/161] (911s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [87.618538] Starting subtest: addfb25-yf-tiled-legacy [87.618990] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [87.727179] [062/161] (911s left) kms_addfb_basic (addfb25-y-tiled-legacy) [87.860017] Starting subtest: addfb25-y-tiled-legacy [87.860511] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [87.933575] [063/161] (911s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [88.064317] Starting subtest: addfb25-y-tiled-small-legacy [88.064904] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [88.163965] [064/161] (911s left) kms_addfb_basic (bad-pitch-0) [88.213864] Starting subtest: bad-pitch-0 [88.214390] Subtest bad-pitch-0: SUCCESS (0.000s) [88.340032] [065/161] (911s left) kms_addfb_basic (bad-pitch-1024) [88.388281] Starting subtest: bad-pitch-1024 [88.388768] Subtest bad-pitch-1024: SUCCESS (0.000s) [88.525948] [066/161] (911s left) kms_addfb_basic (bad-pitch-128) [88.572269] Starting subtest: bad-pitch-128 [88.572751] Subtest bad-pitch-128: SUCCESS (0.000s) [88.714162] [067/161] (910s left) kms_addfb_basic (bad-pitch-256) [88.763096] Starting subtest: bad-pitch-256 [88.763695] Subtest bad-pitch-256: SUCCESS (0.000s) [88.909804] [068/161] (910s left) kms_addfb_basic (bad-pitch-32) [88.958228] Starting subtest: bad-pitch-32 [88.958798] Subtest bad-pitch-32: SUCCESS (0.000s) [89.163339] [069/161] (910s left) kms_addfb_basic (bad-pitch-63) [89.210832] Starting subtest: bad-pitch-63 [89.211238] Subtest bad-pitch-63: SUCCESS (0.000s) [89.349207] [070/161] (910s left) kms_addfb_basic (bad-pitch-65536) [89.398712] Starting subtest: bad-pitch-65536 [89.399273] Subtest bad-pitch-65536: SUCCESS (0.000s) [89.539537] [071/161] (910s left) kms_addfb_basic (bad-pitch-999) [89.588099] Starting subtest: bad-pitch-999 [89.588616] Subtest bad-pitch-999: SUCCESS (0.000s) [89.719221] [072/161] (910s left) kms_addfb_basic (basic) [89.768460] Starting subtest: basic [89.772566] Subtest basic: SUCCESS (0.000s) [89.906502] [073/161] (910s left) kms_addfb_basic (basic-x-tiled-legacy) [89.955351] Starting subtest: basic-x-tiled-legacy [89.955867] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [90.107081] [074/161] (909s left) kms_addfb_basic (basic-y-tiled-legacy) [90.154140] Starting subtest: basic-y-tiled-legacy [90.154617] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [90.285995] [075/161] (909s left) kms_addfb_basic (bo-too-small) [90.414893] Starting subtest: bo-too-small [90.415414] Subtest bo-too-small: SUCCESS (0.000s) [90.472056] [076/161] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling) [90.605867] Starting subtest: bo-too-small-due-to-tiling [90.606393] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [90.683486] [077/161] (909s left) kms_addfb_basic (clobberred-modifier) [90.730645] Starting subtest: clobberred-modifier [90.731029] Subtest clobberred-modifier: SUCCESS (0.000s) [90.878898] [078/161] (909s left) kms_addfb_basic (framebuffer-vs-set-tiling) [90.926588] Starting subtest: framebuffer-vs-set-tiling [90.927027] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [91.064441] [079/161] (909s left) kms_addfb_basic (invalid-get-prop) [91.113089] Starting subtest: invalid-get-prop [91.113554] Subtest invalid-get-prop: SUCCESS (0.000s) [91.265589] [080/161] (908s left) kms_addfb_basic (invalid-get-prop-any) [91.313479] Starting subtest: invalid-get-prop-any [91.313922] Subtest invalid-get-prop-any: SUCCESS (0.000s) [91.454132] [081/161] (908s left) kms_addfb_basic (invalid-set-prop) [91.502985] Starting subtest: invalid-set-prop [91.503606] Subtest invalid-set-prop: SUCCESS (0.000s) [91.661280] [082/161] (908s left) kms_addfb_basic (invalid-set-prop-any) [91.708636] Starting subtest: invalid-set-prop-any [91.709026] Subtest invalid-set-prop-any: SUCCESS (0.000s) [91.857532] [083/161] (908s left) kms_addfb_basic (no-handle) [91.905445] Starting subtest: no-handle [91.905820] Subtest no-handle: SUCCESS (0.000s) [92.045916] [084/161] (908s left) kms_addfb_basic (size-max) [92.174022] Starting subtest: size-max [92.174652] Subtest size-max: SUCCESS (0.000s) [92.241592] [085/161] (908s left) kms_addfb_basic (small-bo) [92.370832] Starting subtest: small-bo [92.371321] Subtest small-bo: SUCCESS (0.000s) [92.425801] [086/161] (908s left) kms_addfb_basic (tile-pitch-mismatch) [92.473346] Starting subtest: tile-pitch-mismatch [92.473805] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [92.652085] [087/161] (907s left) kms_addfb_basic (too-high) [92.782961] Starting subtest: too-high [92.783558] Subtest too-high: SUCCESS (0.001s) [92.876580] [088/161] (907s left) kms_addfb_basic (too-wide) [93.010133] Starting subtest: too-wide [93.010641] Subtest too-wide: SUCCESS (0.000s) [93.076860] [089/161] (907s left) kms_addfb_basic (unused-handle) [93.123259] Starting subtest: unused-handle [93.123696] Subtest unused-handle: SUCCESS (0.000s) [93.260640] [090/161] (907s left) kms_addfb_basic (unused-modifier) [93.306884] Starting subtest: unused-modifier [93.307459] Subtest unused-modifier: SUCCESS (0.000s) [93.468839] [091/161] (907s left) kms_addfb_basic (unused-offsets) [93.518659] Starting subtest: unused-offsets [93.519051] Subtest unused-offsets: SUCCESS (0.000s) [93.683083] [092/161] (907s left) kms_addfb_basic (unused-pitches) [93.731888] Starting subtest: unused-pitches [93.732299] Subtest unused-pitches: SUCCESS (0.000s) [93.860492] [093/161] (906s left) kms_busy (basic) [93.985302] Subtest basic: SKIP (0.000s) [94.021253] [094/161] (906s left) kms_prop_blob (basic) [94.068384] Starting subtest: basic [94.068823] Subtest basic: SUCCESS (0.000s) [94.106165] [095/161] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [94.240206] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [94.273212] [096/161] (906s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [94.405387] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [94.438175] [097/161] (906s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [94.568008] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [94.602570] [098/161] (906s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [94.735160] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [94.767228] [099/161] (906s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [94.898710] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [94.931584] [100/161] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [95.062126] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [95.095749] [101/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [95.228039] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [95.259997] [102/161] (905s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [95.391902] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [95.426056] [103/161] (905s left) kms_dsc (dsc-basic) [95.556226] Subtest dsc-basic: SKIP (0.000s) [95.591041] [104/161] (905s left) kms_flip (basic-flip-vs-dpms) [95.721181] Starting subtest: basic-flip-vs-dpms [95.722050] Subtest basic-flip-vs-dpms: SKIP (0.001s) [95.769152] [105/161] (905s left) kms_flip (basic-flip-vs-modeset) [95.898419] Starting subtest: basic-flip-vs-modeset [95.899455] Subtest basic-flip-vs-modeset: SKIP (0.001s) [95.945490] [106/161] (905s left) kms_flip (basic-flip-vs-wf_vblank) [96.072483] Starting subtest: basic-flip-vs-wf_vblank [96.073682] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [96.142827] [107/161] (905s left) kms_flip (basic-plain-flip) [96.272210] Starting subtest: basic-plain-flip [96.273663] Subtest basic-plain-flip: SKIP (0.001s) [96.320823] [108/161] (904s left) kms_force_connector_basic (force-connector-state) [96.453306] Starting subtest: force-connector-state [96.575322] Subtest force-connector-state: SUCCESS (0.121s) [96.664515] [109/161] (904s left) kms_force_connector_basic (force-edid) [96.801213] Starting subtest: force-edid [96.895410] Subtest force-edid: SUCCESS (0.093s) [97.056330] [110/161] (904s left) kms_force_connector_basic (force-load-detect) [97.179262] Starting subtest: force-load-detect [97.180490] Subtest force-load-detect: SKIP (0.000s) [97.325518] [111/161] (904s left) kms_force_connector_basic (prune-stale-modes) [97.396764] Starting subtest: prune-stale-modes [97.480290] Subtest prune-stale-modes: SUCCESS (0.086s) [97.641160] [112/161] (903s left) kms_frontbuffer_tracking (basic) [97.773479] Subtest basic: SKIP (0.000s) [97.840350] [113/161] (903s left) kms_hdmi_inject (inject-audio) [97.891827] Starting subtest: inject-audio [97.997649] Subtest inject-audio: SUCCESS (0.106s) [98.105785] [114/161] (903s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [98.236163] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [98.273197] [115/161] (903s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [98.379141] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [98.417123] [116/161] (903s left) kms_pipe_crc_basic (hang-read-crc) [98.520548] Subtest hang-read-crc: SKIP (0.000s) [98.557199] [117/161] (903s left) kms_pipe_crc_basic (nonblocking-crc) [98.647991] Subtest nonblocking-crc: SKIP (0.000s) [98.685965] [118/161] (903s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [98.783967] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [98.822236] [119/161] (902s left) kms_pipe_crc_basic (read-crc) [98.914220] Subtest read-crc: SKIP (0.000s) [98.951516] [120/161] (902s left) kms_pipe_crc_basic (read-crc-frame-sequence) [99.056124] Subtest read-crc-frame-sequence: SKIP (0.000s) [99.093513] [121/161] (902s left) kms_pm_backlight (basic-brightness) [99.186147] Subtest basic-brightness: SKIP (0.000s) [99.225142] [122/161] (902s left) kms_pm_rpm (basic-pci-d3-state) [100.554878] Starting subtest: basic-pci-d3-state [100.775796] Subtest basic-pci-d3-state: SUCCESS (0.226s) [100.825114] [123/161] (901s left) kms_pm_rpm (basic-rte) [100.870380] Starting subtest: basic-rte [102.342934] Subtest basic-rte: SUCCESS (1.472s) [102.683941] [124/161] (899s left) kms_psr (psr-primary-page-flip) [102.814461] Subtest psr-primary-page-flip: SKIP (0.000s) [102.852178] [125/161] (899s left) kms_psr (psr-cursor-plane-move) [102.962180] Subtest psr-cursor-plane-move: SKIP (0.000s) [103.001030] [126/161] (899s left) kms_psr (psr-sprite-plane-onoff) [103.103026] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [103.139794] [127/161] (898s left) kms_psr (psr-primary-mmap-gtt) [103.245375] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [103.283574] [128/161] (898s left) kms_setmode (basic-clone-single-crtc) [103.332417] Starting subtest: basic-clone-single-crtc [103.333730] Subtest basic-clone-single-crtc: SKIP (0.000s) [103.371380] [129/161] (898s left) i915_pm_rps (basic-api) [103.426612] Starting subtest: basic-api [103.429531] Subtest basic-api: SUCCESS (0.003s) [103.468022] [130/161] (898s left) prime_self_import (basic-llseek-bad) [103.515815] Starting subtest: basic-llseek-bad [103.518678] Subtest basic-llseek-bad: SUCCESS (0.001s) [103.590482] [131/161] (898s left) prime_self_import (basic-llseek-size) [103.639117] Starting subtest: basic-llseek-size [103.640021] Subtest basic-llseek-size: SUCCESS (0.002s) [103.702143] [132/161] (898s left) prime_self_import (basic-with_fd_dup) [103.747719] Starting subtest: basic-with_fd_dup [103.749946] Subtest basic-with_fd_dup: SUCCESS (0.002s) [103.812602] [133/161] (898s left) prime_self_import (basic-with_one_bo) [103.858694] Starting subtest: basic-with_one_bo [103.859686] Subtest basic-with_one_bo: SUCCESS (0.003s) [103.901053] [134/161] (898s left) prime_self_import (basic-with_one_bo_two_files) [103.946545] Starting subtest: basic-with_one_bo_two_files [103.947980] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [104.010571] [135/161] (898s left) prime_self_import (basic-with_two_bos) [104.057131] Starting subtest: basic-with_two_bos [104.059018] Subtest basic-with_two_bos: SUCCESS (0.002s) [104.118859] [136/161] (898s left) prime_vgem (basic-fence-flip) [104.170958] Starting subtest: basic-fence-flip [104.229702] Subtest basic-fence-flip: SKIP (0.058s) [104.269932] [137/161] (898s left) prime_vgem (basic-fence-mmap) [104.321633] Starting subtest: basic-fence-mmap [104.347087] Subtest basic-fence-mmap: SUCCESS (0.025s) [104.414413] [138/161] (898s left) prime_vgem (basic-fence-read) [104.466259] Starting subtest: basic-fence-read [104.517096] Subtest basic-fence-read: SUCCESS (0.050s) [104.570827] [139/161] (897s left) prime_vgem (basic-gtt) [104.626099] Starting subtest: basic-gtt [104.636582] Subtest basic-gtt: SUCCESS (0.010s) [104.709537] [140/161] (897s left) prime_vgem (basic-read) [104.762899] Starting subtest: basic-read [104.786358] Subtest basic-read: SUCCESS (0.022s) [104.841738] [141/161] (897s left) prime_vgem (basic-write) [104.898298] Starting subtest: basic-write [104.925305] Subtest basic-write: SUCCESS (0.027s) [104.968211] [142/161] (897s left) vgem_basic (setversion) [105.020128] Starting subtest: setversion [105.021533] Subtest setversion: SUCCESS (0.000s) [105.056749] [143/161] (897s left) vgem_basic (create) [105.104628] Starting subtest: create [105.105065] Subtest create: SUCCESS (0.000s) [105.141291] [144/161] (897s left) vgem_basic (debugfs) [105.191338] Starting subtest: debugfs [105.191764] Subtest debugfs: SUCCESS (0.000s) [105.228433] [145/161] (897s left) vgem_basic (dmabuf-export) [105.276816] Starting subtest: dmabuf-export [105.277634] Subtest dmabuf-export: SUCCESS (0.001s) [105.368906] [146/161] (897s left) vgem_basic (dmabuf-fence) [105.418271] Starting subtest: dmabuf-fence [105.418806] Subtest dmabuf-fence: SUCCESS (0.001s) [105.458822] [147/161] (897s left) vgem_basic (dmabuf-fence-before) [105.506563] Starting subtest: dmabuf-fence-before [105.506949] Subtest dmabuf-fence-before: SUCCESS (0.000s) [105.543270] [148/161] (897s left) vgem_basic (dmabuf-mmap) [105.591218] Starting subtest: dmabuf-mmap [105.600600] Subtest dmabuf-mmap: SUCCESS (0.010s) [105.637200] [149/161] (897s left) vgem_basic (mmap) [105.687031] Starting subtest: mmap [105.692573] Subtest mmap: SUCCESS (0.007s) [105.729697] [150/161] (897s left) vgem_basic (second-client) [105.777860] Starting subtest: second-client [105.779796] Subtest second-client: SUCCESS (0.002s) [105.817216] [151/161] (897s left) vgem_basic (sysfs) [105.864557] Starting subtest: sysfs [105.864926] Subtest sysfs: SUCCESS (0.000s) [105.903390] [152/161] (897s left) core_hotunplug (unbind-rebind) [105.997736] Starting subtest: unbind-rebind [109.161142] Subtest unbind-rebind: SUCCESS (3.164s) [109.199179] [153/161] (893s left) vgem_basic (unload) [109.247185] Starting subtest: unload [138.316756] Subtest unload: SUCCESS (29.060s) [138.364951] [154/161] (864s left) i915_module_load (reload) [138.413877] Starting subtest: reload [140.540168] Subtest reload: SUCCESS (2.126s) [140.580408] [155/161] (862s left) gem_lmem_swapping (basic) [140.656766] Subtest basic: SKIP (0.000s) [140.694427] [156/161] (862s left) gem_lmem_swapping (parallel-random-engines) [140.749038] Subtest parallel-random-engines: SKIP (0.000s) [140.783358] [157/161] (862s left) gem_lmem_swapping (random-engines) [140.834262] Subtest random-engines: SKIP (0.000s) [140.869544] [158/161] (862s left) gem_lmem_swapping (verify-random) [140.924550] Subtest verify-random: SKIP (0.000s) [140.957254] [159/161] (862s left) i915_pm_rpm (module-reload) [142.228119] Starting subtest: module-reload [149.653321] Subtest module-reload: SUCCESS (7.424s) [149.680674] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [149.681936] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [149.683739] [160/161] (853s left) i915_selftest (live) [149.733542] Starting subtest: live [149.734043] Starting dynamic subtest: sanitycheck [151.201196] Dynamic subtest sanitycheck: SUCCESS (1.462s) [151.211104] Starting dynamic subtest: uncore [152.609387] Dynamic subtest uncore: SUCCESS (1.409s) [152.619027] Starting dynamic subtest: workarounds [154.306308] Dynamic subtest workarounds: SUCCESS (1.695s) [154.315899] Starting dynamic subtest: gt_engines [156.209497] Dynamic subtest gt_engines: SUCCESS (1.903s) [156.222318] Starting dynamic subtest: gt_timelines [164.000105] Dynamic subtest gt_timelines: SUCCESS (7.788s) [164.023624] Starting dynamic subtest: gt_contexts [165.717470] Dynamic subtest gt_contexts: SUCCESS (1.717s) [165.728798] Starting dynamic subtest: gt_lrc [169.682658] Dynamic subtest gt_lrc: SUCCESS (3.964s) [169.695497] Starting dynamic subtest: gt_mocs [171.290180] Dynamic subtest gt_mocs: SUCCESS (1.606s) [171.302739] Starting dynamic subtest: gt_pm [177.167972] Dynamic subtest gt_pm: SUCCESS (5.877s) [177.176989] Starting dynamic subtest: gt_heartbeat [178.564277] Dynamic subtest gt_heartbeat: SUCCESS (1.396s) [178.573538] Starting dynamic subtest: gt_tlb [180.952831] Dynamic subtest gt_tlb: SUCCESS (2.384s) [180.960707] Starting dynamic subtest: requests [188.775637] Dynamic subtest requests: SUCCESS (7.821s) [188.785009] Starting dynamic subtest: migrate [193.471738] Dynamic subtest migrate: SUCCESS (4.695s) [193.480995] Starting dynamic subtest: active [194.990829] Dynamic subtest active: SUCCESS (1.518s) [194.999967] Starting dynamic subtest: objects [197.171372] Dynamic subtest objects: SUCCESS (2.179s) [197.184067] Starting dynamic subtest: mman [201.955384] Dynamic subtest mman: SUCCESS (4.784s) [201.964610] Starting dynamic subtest: dmabuf [203.523089] Dynamic subtest dmabuf: SUCCESS (1.566s) [203.532646] Starting dynamic subtest: vma [205.002693] Dynamic subtest vma: SUCCESS (1.479s) [205.011190] Starting dynamic subtest: coherency [207.212162] Dynamic subtest coherency: SUCCESS (2.208s) [207.224958] Starting dynamic subtest: gtt [216.194221] Dynamic subtest gtt: SUCCESS (8.981s) [216.203750] Starting dynamic subtest: gem [218.053632] Dynamic subtest gem: SUCCESS (1.858s) [218.062953] Starting dynamic subtest: evict [220.661461] Dynamic subtest evict: SUCCESS (2.606s) [220.670587] Starting dynamic subtest: hugepages [228.860856] Dynamic subtest hugepages: SUCCESS (8.198s) [228.889323] Starting dynamic subtest: gem_contexts [242.889897] Dynamic subtest gem_contexts: SUCCESS (14.027s) [242.898842] Starting dynamic subtest: client [244.447766] Dynamic subtest client: SUCCESS (1.556s) [244.454763] Starting dynamic subtest: gem_migrate [245.892066] Dynamic subtest gem_migrate: SUCCESS (1.442s) [245.903709] Starting dynamic subtest: reset [247.784416] Dynamic subtest reset: SUCCESS (1.892s) [247.793955] Starting dynamic subtest: memory_region [249.229387] Dynamic subtest memory_region: SUCCESS (1.444s) [249.237164] Starting dynamic subtest: hangcheck [273.888650] Dynamic subtest hangcheck: SUCCESS (24.657s) [273.896112] Starting dynamic subtest: execlists [284.253213] Dynamic subtest execlists: SUCCESS (10.361s) [284.262935] Starting dynamic subtest: ring_submission [285.703740] Dynamic subtest ring_submission: SUCCESS (1.448s) [285.711045] Starting dynamic subtest: perf [287.320165] Dynamic subtest perf: SUCCESS (1.615s) [287.329425] Starting dynamic subtest: slpc [288.665978] Dynamic subtest slpc: SUCCESS (1.344s) [288.677629] Starting dynamic subtest: guc [290.075700] Dynamic subtest guc: SUCCESS (1.408s) [290.088415] Starting dynamic subtest: guc_multi_lrc [291.515825] Dynamic subtest guc_multi_lrc: SUCCESS (1.438s) [291.525378] Starting dynamic subtest: guc_hang [292.946128] Dynamic subtest guc_hang: SUCCESS (1.429s) [292.955495] Starting dynamic subtest: late_gt_pm [294.434873] Dynamic subtest late_gt_pm: SUCCESS (1.486s) [294.435874] Subtest live: SUCCESS (144.694s) [294.493480] [161/161] (708s left) dmabuf (all-tests) [294.551961] Starting subtest: all-tests [294.553282] Starting dynamic subtest: sanitycheck [294.674715] Dynamic subtest sanitycheck: SUCCESS (0.118s) [294.720095] Starting dynamic subtest: dma_fence [294.976211] Dynamic subtest dma_fence: SUCCESS (0.294s) [295.012408] Starting dynamic subtest: dma_fence_chain [305.524129] Dynamic subtest dma_fence_chain: SUCCESS (10.539s) [305.546855] Starting dynamic subtest: dma_fence_unwrap [305.661822] Dynamic subtest dma_fence_unwrap: SUCCESS (0.131s) [305.700961] Starting dynamic subtest: dma_resv [305.808680] Dynamic subtest dma_resv: SUCCESS (0.140s) [305.810744] Subtest all-tests: SUCCESS (11.255s) [305.881500] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: debugfs_test results: parsing output: 3/ for test: debugfs_test results: parsing output: 4/ for test: debugfs_test results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: fbdev results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_basic results: parsing output: 13/ for test: gem_busy results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_close_race results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_create results: parsing output: 18/ for test: gem_ctx_exec results: parsing output: 19/ for test: gem_exec_basic results: parsing output: 20/ for test: gem_exec_create results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: gem_exec_gttfill results: parsing output: 26/ for test: gem_exec_parallel results: parsing output: 27/ for test: gem_exec_store results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_flink_basic results: parsing output: 33/ for test: gem_huc_copy results: parsing output: 34/ for test: gem_linear_blits results: parsing output: 35/ for test: gem_mmap results: parsing output: 36/ for test: gem_mmap_gtt results: parsing output: 37/ for test: gem_render_linear_blits results: parsing output: 38/ for test: gem_render_tiled_blits results: parsing output: 39/ for test: gem_ringfill results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_softpin results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_sync results: parsing output: 45/ for test: gem_tiled_blits results: parsing output: 46/ for test: gem_tiled_fence_blits results: parsing output: 47/ for test: gem_tiled_pread_basic results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: gem_wait results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_getparams_basic results: parsing output: 52/ for test: i915_hangman results: parsing output: 53/ for test: i915_pciid results: parsing output: 54/ for test: kms_addfb_basic results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_busy results: parsing output: 93/ for test: kms_prop_blob results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_dsc results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_force_connector_basic results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_hdmi_inject results: parsing output: 113/ for test: kms_pipe_crc_basic results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pm_backlight results: parsing output: 121/ for test: kms_pm_rpm results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_setmode results: parsing output: 128/ for test: i915_pm_rps results: parsing output: 129/ for test: prime_self_import results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_vgem results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: vgem_basic results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: core_hotunplug results: parsing output: 152/ for test: vgem_basic results: parsing output: 153/ for test: i915_module_load results: parsing output: 154/ for test: gem_lmem_swapping results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: i915_pm_rpm results: parsing output: 159/ for test: i915_selftest results: parsing output: 160/ for test: dmabuf Done.