[39.012756] Initializing watchdogs [39.012865] /dev/watchdog0 [39.038380] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [39.045543] [001/162] (960s left) i915_module_load (load) [39.638390] Starting subtest: load [41.899112] Subtest load: SUCCESS (2.262s) [41.944983] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [41.947108] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [41.951076] [002/162] (957s left) core_auth (basic-auth) [42.064533] Starting subtest: basic-auth [42.065775] Subtest basic-auth: SUCCESS (0.002s) [42.133627] [003/162] (957s left) core_debugfs (read-all-entries) [42.193935] Starting subtest: read-all-entries [42.197183] Subtest read-all-entries: SUCCESS (0.005s) [42.250190] [004/162] (957s left) core_sysfs (read-all-entries) [42.308894] Starting subtest: read-all-entries [42.313248] Subtest read-all-entries: SUCCESS (0.005s) [42.362463] [005/162] (957s left) fbdev (eof) [42.433211] Subtest eof: SKIP (0.000s) [42.480285] [006/162] (957s left) fbdev (info) [42.550075] Subtest info: SKIP (0.000s) [42.598241] [007/162] (957s left) fbdev (nullptr) [42.667370] Subtest nullptr: SKIP (0.000s) [42.714616] [008/162] (957s left) fbdev (read) [42.784166] Subtest read: SKIP (0.000s) [42.831560] [009/162] (957s left) fbdev (write) [42.902537] Subtest write: SKIP (0.000s) [42.950633] [010/162] (957s left) gem_basic (bad-close) [43.008179] Starting subtest: bad-close [43.010091] Subtest bad-close: SUCCESS (0.000s) [43.058179] [011/162] (957s left) gem_basic (create-close) [43.118871] Starting subtest: create-close [43.120894] Subtest create-close: SUCCESS (0.000s) [43.192383] [012/162] (956s left) gem_basic (create-fd-close) [43.252301] Starting subtest: create-fd-close [43.254186] Subtest create-fd-close: SUCCESS (0.000s) [43.314678] [013/162] (956s left) gem_busy (busy@all-engines) [43.396675] Starting subtest: busy [43.397666] Starting dynamic subtest: all-engines [43.459245] Dynamic subtest all-engines: SUCCESS (0.061s) [43.460349] Subtest busy: SUCCESS (0.062s) [43.849053] [014/162] (956s left) gem_close_race (basic-process) [43.932999] Starting subtest: basic-process [43.996987] Subtest basic-process: SUCCESS (0.065s) [44.241295] [015/162] (956s left) gem_close_race (basic-threads) [44.325397] Starting subtest: basic-threads [45.556319] Subtest basic-threads: SUCCESS (1.231s) [45.773771] [016/162] (954s left) gem_ctx_create (basic) [45.848590] Starting subtest: basic [45.849728] Subtest basic: SUCCESS (0.000s) [46.034229] [017/162] (954s left) gem_ctx_create (basic-files) [46.112621] Starting subtest: basic-files [48.128018] Subtest basic-files: SUCCESS (2.016s) [48.361650] [018/162] (952s left) gem_ctx_exec (basic) [48.429944] Starting subtest: basic [48.436757] Subtest basic: SUCCESS (0.007s) [48.510600] [019/162] (952s left) gem_exec_basic (basic) [48.583912] Starting subtest: basic [48.585061] Starting dynamic subtest: rcs0-smem [48.587657] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [48.600929] Starting dynamic subtest: bcs0-smem [48.602496] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [48.614425] Starting dynamic subtest: vcs0-smem [48.616491] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [48.627702] Starting dynamic subtest: vcs1-smem [48.629024] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [48.639781] Starting dynamic subtest: vecs0-smem [48.641112] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [48.642467] Subtest basic: SUCCESS (0.011s) [48.822353] [020/162] (951s left) gem_exec_create (basic) [49.014414] Starting subtest: basic [49.015729] Starting dynamic subtest: smem [51.098923] Dynamic subtest smem: SUCCESS (2.047s) [51.100916] Subtest basic: SUCCESS (2.048s) [51.263591] [021/162] (949s left) gem_exec_fence (basic-busy) [51.478112] Starting subtest: basic-busy [51.480156] Starting dynamic subtest: rcs0 [51.516732] Dynamic subtest rcs0: SUCCESS (0.038s) [51.539994] Starting dynamic subtest: bcs0 [51.548596] Dynamic subtest bcs0: SUCCESS (0.031s) [51.571170] Starting dynamic subtest: vcs0 [51.575679] Dynamic subtest vcs0: SUCCESS (0.026s) [51.593253] Starting dynamic subtest: vcs1 [51.604281] Dynamic subtest vcs1: SUCCESS (0.027s) [51.618095] Starting dynamic subtest: vecs0 [51.628468] Dynamic subtest vecs0: SUCCESS (0.024s) [51.629849] Subtest basic-busy: SUCCESS (0.151s) [52.345741] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [52.348824] [022/162] (948s left) gem_exec_fence (basic-wait) [52.562926] Starting subtest: basic-wait [52.565608] Starting dynamic subtest: rcs0 [52.599369] Dynamic subtest rcs0: SUCCESS (0.037s) [52.621130] Starting dynamic subtest: bcs0 [52.632624] Dynamic subtest bcs0: SUCCESS (0.033s) [52.647624] Starting dynamic subtest: vcs0 [52.657887] Dynamic subtest vcs0: SUCCESS (0.024s) [52.672904] Starting dynamic subtest: vcs1 [52.678391] Dynamic subtest vcs1: SUCCESS (0.021s) [52.693060] Starting dynamic subtest: vecs0 [52.703534] Dynamic subtest vecs0: SUCCESS (0.025s) [52.704945] Subtest basic-wait: SUCCESS (0.142s) [53.365295] [023/162] (947s left) gem_exec_fence (basic-await) [53.587385] Starting subtest: basic-await [53.588668] Starting dynamic subtest: rcs0 [53.700834] Dynamic subtest rcs0: SUCCESS (0.109s) [53.721903] Starting dynamic subtest: bcs0 [53.813586] Dynamic subtest bcs0: SUCCESS (0.118s) [53.830738] Starting dynamic subtest: vcs0 [53.923380] Dynamic subtest vcs0: SUCCESS (0.109s) [53.943598] Starting dynamic subtest: vcs1 [54.045218] Dynamic subtest vcs1: SUCCESS (0.122s) [54.059601] Starting dynamic subtest: vecs0 [54.156777] Dynamic subtest vecs0: SUCCESS (0.111s) [54.158102] Subtest basic-await: SUCCESS (0.571s) [54.864282] [024/162] (946s left) gem_exec_fence (nb-await) [55.094622] Starting subtest: nb-await [55.096138] Starting dynamic subtest: rcs0 [55.167246] Dynamic subtest rcs0: SUCCESS (0.074s) [55.197299] Starting dynamic subtest: bcs0 [55.251487] Dynamic subtest bcs0: SUCCESS (0.082s) [55.283616] Starting dynamic subtest: vcs0 [55.336916] Dynamic subtest vcs0: SUCCESS (0.084s) [55.370419] Starting dynamic subtest: vcs1 [55.424705] Dynamic subtest vcs1: SUCCESS (0.086s) [55.462719] Starting dynamic subtest: vecs0 [55.518877] Dynamic subtest vecs0: SUCCESS (0.090s) [55.522421] Subtest nb-await: SUCCESS (0.427s) [56.154977] [025/162] (944s left) gem_exec_gttfill (basic) [56.239766] Starting subtest: basic [61.505899] Subtest basic: SUCCESS (5.266s) [61.764780] [026/162] (939s left) gem_exec_parallel (engines) [61.936865] Starting subtest: engines [61.980376] Starting dynamic subtest: basic [64.270920] Dynamic subtest basic: SUCCESS (2.290s) [64.283718] Starting dynamic subtest: contexts [72.415755] Dynamic subtest contexts: SUCCESS (8.175s) [72.428424] Starting dynamic subtest: fds [77.727485] Dynamic subtest fds: SUCCESS (5.324s) [77.740447] Starting dynamic subtest: userptr [80.188998] Dynamic subtest userptr: SUCCESS (2.426s) [80.191219] Subtest engines: SUCCESS (18.216s) [80.372556] [027/162] (920s left) gem_exec_store (basic) [80.461656] Starting subtest: basic [80.512677] Subtest basic: SUCCESS (0.051s) [80.702967] [028/162] (920s left) gem_flink_basic (bad-flink) [80.763199] Starting subtest: bad-flink [80.764413] Subtest bad-flink: SUCCESS (0.000s) [80.824663] [029/162] (920s left) gem_flink_basic (bad-open) [80.883885] Starting subtest: bad-open [80.885066] Subtest bad-open: SUCCESS (0.000s) [80.940440] [030/162] (920s left) gem_flink_basic (basic) [81.227192] Starting subtest: basic [81.229409] Subtest basic: SUCCESS (0.000s) [81.330223] [031/162] (920s left) gem_flink_basic (double-flink) [81.434457] Starting subtest: double-flink [81.435617] Subtest double-flink: SUCCESS (0.000s) [81.526472] [032/162] (920s left) gem_flink_basic (flink-lifetime) [81.586166] Starting subtest: flink-lifetime [81.587232] Subtest flink-lifetime: SUCCESS (0.002s) [81.674768] [033/162] (919s left) gem_huc_copy (huc-copy) [81.743610] Starting subtest: huc-copy [81.745889] Subtest huc-copy: SKIP (0.000s) [81.837465] [034/162] (919s left) gem_linear_blits (basic) [82.032599] Starting subtest: basic [82.039603] Subtest basic: SUCCESS (0.007s) [82.146757] [035/162] (919s left) gem_mmap (basic) [82.324431] Starting subtest: basic [82.329389] Subtest basic: SUCCESS (0.001s) [82.418311] [036/162] (919s left) gem_mmap_gtt (basic) [82.479061] Starting subtest: basic [82.480126] Subtest basic: SUCCESS (0.001s) [82.541541] [037/162] (919s left) gem_render_linear_blits (basic) [82.608164] Starting subtest: basic [82.639086] Subtest basic: SUCCESS (0.031s) [82.717926] [038/162] (919s left) gem_render_tiled_blits (basic) [82.787557] Starting subtest: basic [82.829147] Subtest basic: SUCCESS (0.042s) [82.900803] [039/162] (919s left) gem_ringfill (basic-all) [83.202170] Starting subtest: basic-all [84.430444] Subtest basic-all: SUCCESS (1.175s) [84.490201] [040/162] (917s left) gem_softpin (allocator-basic) [84.568453] Starting subtest: allocator-basic [84.769032] Subtest allocator-basic: SUCCESS (0.147s) [84.824393] [041/162] (917s left) gem_softpin (allocator-basic-reserve) [84.897115] Starting subtest: allocator-basic-reserve [85.128021] Subtest allocator-basic-reserve: SUCCESS (0.147s) [85.190241] [042/162] (917s left) gem_softpin (safe-alignment) [85.263803] Starting subtest: safe-alignment [85.282909] Subtest safe-alignment: SUCCESS (0.019s) [85.384810] [043/162] (916s left) gem_sync (basic-all) [85.469609] Starting subtest: basic-all [87.929630] Subtest basic-all: SUCCESS (2.422s) [88.087633] [044/162] (914s left) gem_sync (basic-each) [88.169645] Starting subtest: basic-each [90.377668] Subtest basic-each: SUCCESS (2.208s) [90.678294] [045/162] (911s left) gem_tiled_blits (basic) [90.847630] Starting subtest: basic [90.865875] Subtest basic: SUCCESS (0.018s) [90.978913] [046/162] (911s left) gem_tiled_fence_blits (basic) [91.565769] Starting subtest: basic [91.577554] Subtest basic: SUCCESS (0.012s) [91.673937] [047/162] (910s left) gem_tiled_pread_basic (basic) [91.795068] Starting subtest: basic [91.942850] Subtest basic: SUCCESS (0.148s) [92.020651] [048/162] (910s left) gem_wait (busy@all-engines) [92.104677] Starting subtest: busy [92.105986] Starting dynamic subtest: all-engines [92.699632] Dynamic subtest all-engines: SUCCESS (0.594s) [92.701776] Subtest busy: SUCCESS (0.594s) [93.001074] [049/162] (909s left) gem_wait (wait@all-engines) [93.088091] Starting subtest: wait [93.089245] Starting dynamic subtest: all-engines [94.177549] Dynamic subtest all-engines: SUCCESS (1.043s) [94.180177] Subtest wait: SUCCESS (1.044s) [94.356074] [050/162] (908s left) i915_getparams_basic (basic-eu-total) [94.419233] Starting subtest: basic-eu-total [94.421440] Subtest basic-eu-total: SUCCESS (0.000s) [94.476814] [051/162] (908s left) i915_getparams_basic (basic-subslice-total) [94.537459] Starting subtest: basic-subslice-total [94.539629] Subtest basic-subslice-total: SUCCESS (0.000s) [94.594132] [052/162] (908s left) i915_hangman (error-state-basic) [94.684451] Starting subtest: error-state-basic [94.694547] Subtest error-state-basic: SUCCESS (0.010s) [94.873844] [053/162] (908s left) i915_pciid [95.167868] [054/162] (907s left) intel_hwmon (hwmon-read) [95.228320] Subtest hwmon-read: SKIP (0.000s) [95.285740] [055/162] (907s left) intel_hwmon (hwmon-write) [95.345678] Subtest hwmon-write: SKIP (0.000s) [95.402427] [056/162] (907s left) kms_addfb_basic (addfb25-4-tiled) [95.694890] Starting subtest: addfb25-4-tiled [95.697113] Subtest addfb25-4-tiled: SUCCESS (0.001s) [95.795719] [057/162] (907s left) kms_addfb_basic (addfb25-bad-modifier) [96.068702] Starting subtest: addfb25-bad-modifier [96.069912] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [96.151737] [058/162] (907s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [96.434688] Starting subtest: addfb25-framebuffer-vs-set-tiling [96.435917] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.517463] [059/162] (906s left) kms_addfb_basic (addfb25-modifier-no-flag) [96.791756] Starting subtest: addfb25-modifier-no-flag [96.792960] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [96.872657] [060/162] (906s left) kms_addfb_basic (addfb25-x-tiled-legacy) [97.143518] Starting subtest: addfb25-x-tiled-legacy [97.144793] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [97.236294] [061/162] (906s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [97.510619] Starting subtest: addfb25-x-tiled-mismatch-legacy [97.511883] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [97.591634] [062/162] (906s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [97.860596] Starting subtest: addfb25-yf-tiled-legacy [97.862124] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [97.946994] [063/162] (905s left) kms_addfb_basic (addfb25-y-tiled-legacy) [98.212617] Starting subtest: addfb25-y-tiled-legacy [98.213927] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [98.321881] [064/162] (905s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [98.595206] Starting subtest: addfb25-y-tiled-small-legacy [98.596873] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [98.676744] [065/162] (905s left) kms_addfb_basic (bad-pitch-0) [98.735958] Starting subtest: bad-pitch-0 [98.737042] Subtest bad-pitch-0: SUCCESS (0.000s) [99.033786] [066/162] (904s left) kms_addfb_basic (bad-pitch-1024) [99.093526] Starting subtest: bad-pitch-1024 [99.094551] Subtest bad-pitch-1024: SUCCESS (0.000s) [99.386470] [067/162] (904s left) kms_addfb_basic (bad-pitch-128) [99.446418] Starting subtest: bad-pitch-128 [99.447378] Subtest bad-pitch-128: SUCCESS (0.000s) [99.743553] [068/162] (904s left) kms_addfb_basic (bad-pitch-256) [99.804872] Starting subtest: bad-pitch-256 [99.806142] Subtest bad-pitch-256: SUCCESS (0.000s) [100.104996] [069/162] (904s left) kms_addfb_basic (bad-pitch-32) [100.165927] Starting subtest: bad-pitch-32 [100.167049] Subtest bad-pitch-32: SUCCESS (0.000s) [100.467337] [070/162] (903s left) kms_addfb_basic (bad-pitch-63) [100.543220] Starting subtest: bad-pitch-63 [100.544283] Subtest bad-pitch-63: SUCCESS (0.000s) [100.854426] [071/162] (903s left) kms_addfb_basic (bad-pitch-65536) [100.913214] Starting subtest: bad-pitch-65536 [100.914252] Subtest bad-pitch-65536: SUCCESS (0.000s) [101.236377] [072/162] (903s left) kms_addfb_basic (bad-pitch-999) [101.296053] Starting subtest: bad-pitch-999 [101.297375] Subtest bad-pitch-999: SUCCESS (0.000s) [101.590760] [073/162] (902s left) kms_addfb_basic (basic) [101.651043] Starting subtest: basic [101.652058] Subtest basic: SUCCESS (0.000s) [101.941812] [074/162] (902s left) kms_addfb_basic (basic-x-tiled-legacy) [102.002207] Starting subtest: basic-x-tiled-legacy [102.003186] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [102.294563] [075/162] (902s left) kms_addfb_basic (basic-y-tiled-legacy) [102.355176] Starting subtest: basic-y-tiled-legacy [102.356185] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [102.659193] [076/162] (901s left) kms_addfb_basic (bo-too-small) [102.929600] Starting subtest: bo-too-small [102.930690] Subtest bo-too-small: SUCCESS (0.001s) [103.015698] [077/162] (901s left) kms_addfb_basic (bo-too-small-due-to-tiling) [103.286836] Starting subtest: bo-too-small-due-to-tiling [103.288734] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [103.368710] [078/162] (901s left) kms_addfb_basic (clobberred-modifier) [103.428154] Starting subtest: clobberred-modifier [103.429074] Subtest clobberred-modifier: SUCCESS (0.000s) [103.743910] [079/162] (901s left) kms_addfb_basic (framebuffer-vs-set-tiling) [103.802502] Starting subtest: framebuffer-vs-set-tiling [103.803517] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [104.117218] [080/162] (900s left) kms_addfb_basic (invalid-get-prop) [104.178308] Starting subtest: invalid-get-prop [104.179225] Subtest invalid-get-prop: SUCCESS (0.000s) [104.496077] [081/162] (900s left) kms_addfb_basic (invalid-get-prop-any) [104.555698] Starting subtest: invalid-get-prop-any [104.556666] Subtest invalid-get-prop-any: SUCCESS (0.000s) [104.854600] [082/162] (900s left) kms_addfb_basic (invalid-set-prop) [104.915512] Starting subtest: invalid-set-prop [104.916481] Subtest invalid-set-prop: SUCCESS (0.000s) [105.212145] [083/162] (899s left) kms_addfb_basic (invalid-set-prop-any) [105.271187] Starting subtest: invalid-set-prop-any [105.272198] Subtest invalid-set-prop-any: SUCCESS (0.000s) [105.566417] [084/162] (899s left) kms_addfb_basic (no-handle) [105.625214] Starting subtest: no-handle [105.626230] Subtest no-handle: SUCCESS (0.000s) [105.916426] [085/162] (899s left) kms_addfb_basic (size-max) [106.187518] Starting subtest: size-max [106.189211] Subtest size-max: SUCCESS (0.001s) [106.288145] [086/162] (899s left) kms_addfb_basic (small-bo) [106.558929] Starting subtest: small-bo [106.560353] Subtest small-bo: SUCCESS (0.000s) [106.655207] [087/162] (898s left) kms_addfb_basic (tile-pitch-mismatch) [106.715274] Starting subtest: tile-pitch-mismatch [106.716758] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [107.014612] [088/162] (898s left) kms_addfb_basic (too-high) [107.290756] Starting subtest: too-high [107.292149] Subtest too-high: SUCCESS (0.001s) [107.386244] [089/162] (898s left) kms_addfb_basic (too-wide) [107.661348] Starting subtest: too-wide [107.662352] Subtest too-wide: SUCCESS (0.000s) [107.745435] [090/162] (897s left) kms_addfb_basic (unused-handle) [107.805285] Starting subtest: unused-handle [107.806240] Subtest unused-handle: SUCCESS (0.000s) [108.112909] [091/162] (897s left) kms_addfb_basic (unused-modifier) [108.173433] Starting subtest: unused-modifier [108.174884] Subtest unused-modifier: SUCCESS (0.000s) [108.500547] [092/162] (897s left) kms_addfb_basic (unused-offsets) [108.561166] Starting subtest: unused-offsets [108.562164] Subtest unused-offsets: SUCCESS (0.000s) [108.871452] [093/162] (896s left) kms_addfb_basic (unused-pitches) [108.931426] Starting subtest: unused-pitches [108.932428] Subtest unused-pitches: SUCCESS (0.000s) [109.239249] [094/162] (896s left) kms_busy (basic) [109.520662] Subtest basic: SKIP (0.000s) [109.585129] [095/162] (896s left) kms_prop_blob (basic) [109.645948] Starting subtest: basic [109.646982] Subtest basic: SUCCESS (0.000s) [109.704036] [096/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [109.995461] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [110.054920] [097/162] (896s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [110.331781] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [110.398359] [098/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [110.676497] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [110.734039] [099/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [111.012858] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [111.071977] [100/162] (895s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [111.344824] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [111.404598] [101/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [111.680093] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [111.746835] [102/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [112.025853] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [112.085559] [103/162] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [112.365122] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [112.424775] [104/162] (894s left) kms_dsc (dsc-basic) [112.690878] Subtest dsc-basic: SKIP (0.000s) [112.759596] [105/162] (893s left) kms_flip (basic-flip-vs-dpms) [113.036743] Starting subtest: basic-flip-vs-dpms [113.040101] Subtest basic-flip-vs-dpms: SKIP (0.002s) [113.120179] [106/162] (893s left) kms_flip (basic-flip-vs-modeset) [113.385752] Starting subtest: basic-flip-vs-modeset [113.389207] Subtest basic-flip-vs-modeset: SKIP (0.003s) [113.468352] [107/162] (893s left) kms_flip (basic-flip-vs-wf_vblank) [113.736375] Starting subtest: basic-flip-vs-wf_vblank [113.738523] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [113.816791] [108/162] (892s left) kms_flip (basic-plain-flip) [114.082402] Starting subtest: basic-plain-flip [114.085559] Subtest basic-plain-flip: SKIP (0.002s) [114.160950] [109/162] (892s left) kms_force_connector_basic (force-connector-state) [114.550337] Starting subtest: force-connector-state [115.327156] Subtest force-connector-state: SUCCESS (0.777s) [115.700742] [110/162] (891s left) kms_force_connector_basic (force-edid) [116.089290] Starting subtest: force-edid [116.823750] Subtest force-edid: SUCCESS (0.737s) [117.419152] [111/162] (889s left) kms_force_connector_basic (force-load-detect) [117.804090] Starting subtest: force-load-detect [117.806970] Subtest force-load-detect: SKIP (0.000s) [118.193586] [112/162] (888s left) kms_force_connector_basic (prune-stale-modes) [118.584964] Starting subtest: prune-stale-modes [119.311972] Subtest prune-stale-modes: SUCCESS (0.728s) [119.805974] [113/162] (887s left) kms_frontbuffer_tracking (basic) [120.078148] Subtest basic: SKIP (0.000s) [120.165973] [114/162] (886s left) kms_hdmi_inject (inject-audio) [120.231792] Starting subtest: inject-audio [120.857054] Subtest inject-audio: SUCCESS (0.624s) [121.116544] [115/162] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [121.389719] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [121.463221] [116/162] (885s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [121.734776] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [121.805901] [117/162] (885s left) kms_pipe_crc_basic (hang-read-crc) [122.081532] Subtest hang-read-crc: SKIP (0.000s) [122.163539] [118/162] (885s left) kms_pipe_crc_basic (nonblocking-crc) [122.435860] Subtest nonblocking-crc: SKIP (0.000s) [122.505793] [119/162] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [122.773129] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [122.840805] [120/162] (884s left) kms_pipe_crc_basic (read-crc) [123.109766] Subtest read-crc: SKIP (0.000s) [123.179337] [121/162] (884s left) kms_pipe_crc_basic (read-crc-frame-sequence) [123.448737] Subtest read-crc-frame-sequence: SKIP (0.000s) [123.520768] [122/162] (884s left) kms_pm_backlight (basic-brightness) [123.786741] Subtest basic-brightness: SKIP (0.000s) [123.852072] [123/162] (883s left) kms_pm_rpm (basic-pci-d3-state) [125.491993] Starting subtest: basic-pci-d3-state [125.816352] Subtest basic-pci-d3-state: SUCCESS (0.323s) [125.987655] [124/162] (881s left) kms_pm_rpm (basic-rte) [126.306087] Starting subtest: basic-rte [128.165597] Subtest basic-rte: SUCCESS (1.897s) [128.636498] [125/162] (879s left) kms_psr (psr-primary-page-flip) [129.162823] Subtest psr-primary-page-flip: SKIP (0.000s) [129.229929] [126/162] (878s left) kms_psr (psr-cursor-plane-move) [129.495961] Subtest psr-cursor-plane-move: SKIP (0.000s) [129.564085] [127/162] (878s left) kms_psr (psr-sprite-plane-onoff) [129.834162] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [129.919331] [128/162] (878s left) kms_psr (psr-primary-mmap-gtt) [130.194738] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [130.264084] [129/162] (877s left) kms_setmode (basic-clone-single-crtc) [130.325770] Starting subtest: basic-clone-single-crtc [130.329149] Subtest basic-clone-single-crtc: SKIP (0.000s) [130.391651] [130/162] (877s left) i915_pm_rps (basic-api) [130.490381] Starting subtest: basic-api [130.491383] Subtest basic-api: SUCCESS (0.004s) [130.578284] [131/162] (877s left) prime_self_import (basic-llseek-bad) [130.635442] Starting subtest: basic-llseek-bad [130.638824] Subtest basic-llseek-bad: SUCCESS (0.003s) [130.724110] [132/162] (877s left) prime_self_import (basic-llseek-size) [130.779987] Starting subtest: basic-llseek-size [130.785283] Subtest basic-llseek-size: SUCCESS (0.005s) [130.873735] [133/162] (877s left) prime_self_import (basic-with_fd_dup) [130.930439] Starting subtest: basic-with_fd_dup [130.936462] Subtest basic-with_fd_dup: SUCCESS (0.005s) [131.020762] [134/162] (877s left) prime_self_import (basic-with_one_bo) [131.076346] Starting subtest: basic-with_one_bo [131.081170] Subtest basic-with_one_bo: SUCCESS (0.005s) [131.154791] [135/162] (877s left) prime_self_import (basic-with_one_bo_two_files) [131.212301] Starting subtest: basic-with_one_bo_two_files [131.215357] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [131.297785] [136/162] (877s left) prime_self_import (basic-with_two_bos) [131.356423] Starting subtest: basic-with_two_bos [131.358981] Subtest basic-with_two_bos: SUCCESS (0.004s) [131.440719] [137/162] (877s left) prime_vgem (basic-fence-flip) [131.509442] Starting subtest: basic-fence-flip [131.718451] Subtest basic-fence-flip: SKIP (0.208s) [131.788982] [138/162] (876s left) prime_vgem (basic-fence-mmap) [131.859279] Starting subtest: basic-fence-mmap [131.894616] Subtest basic-fence-mmap: SUCCESS (0.036s) [131.988044] [139/162] (876s left) prime_vgem (basic-fence-read) [132.057146] Starting subtest: basic-fence-read [132.132432] Subtest basic-fence-read: SUCCESS (0.075s) [132.200948] [140/162] (876s left) prime_vgem (basic-gtt) [132.271445] Starting subtest: basic-gtt [132.291602] Subtest basic-gtt: SUCCESS (0.019s) [132.369681] [141/162] (876s left) prime_vgem (basic-read) [132.440272] Starting subtest: basic-read [132.477225] Subtest basic-read: SUCCESS (0.038s) [132.565210] [142/162] (876s left) prime_vgem (basic-write) [132.635899] Starting subtest: basic-write [132.675613] Subtest basic-write: SUCCESS (0.040s) [132.748480] [143/162] (876s left) vgem_basic (setversion) [132.810743] Starting subtest: setversion [132.812645] Subtest setversion: SUCCESS (0.000s) [132.872369] [144/162] (876s left) vgem_basic (create) [132.933942] Starting subtest: create [132.935119] Subtest create: SUCCESS (0.000s) [132.997557] [145/162] (876s left) vgem_basic (debugfs) [133.060251] Starting subtest: debugfs [133.062238] Subtest debugfs: SUCCESS (0.000s) [133.122074] [146/162] (876s left) vgem_basic (dmabuf-export) [133.183219] Starting subtest: dmabuf-export [133.185196] Subtest dmabuf-export: SUCCESS (0.003s) [133.266179] [147/162] (875s left) vgem_basic (dmabuf-fence) [133.327343] Starting subtest: dmabuf-fence [133.328342] Subtest dmabuf-fence: SUCCESS (0.001s) [133.391189] [148/162] (875s left) vgem_basic (dmabuf-fence-before) [133.453739] Starting subtest: dmabuf-fence-before [133.454771] Subtest dmabuf-fence-before: SUCCESS (0.000s) [133.514076] [149/162] (875s left) vgem_basic (dmabuf-mmap) [133.574964] Starting subtest: dmabuf-mmap [133.591724] Subtest dmabuf-mmap: SUCCESS (0.017s) [133.657398] [150/162] (875s left) vgem_basic (mmap) [133.719640] Starting subtest: mmap [133.728859] Subtest mmap: SUCCESS (0.010s) [133.790305] [151/162] (875s left) vgem_basic (second-client) [133.851124] Starting subtest: second-client [133.857078] Subtest second-client: SUCCESS (0.005s) [133.923091] [152/162] (875s left) vgem_basic (sysfs) [133.985090] Starting subtest: sysfs [133.986143] Subtest sysfs: SUCCESS (0.001s) [134.049651] [153/162] (875s left) core_hotunplug (unbind-rebind) [134.160241] Starting subtest: unbind-rebind [138.361837] Subtest unbind-rebind: SUCCESS (4.196s) [138.419697] [154/162] (871s left) vgem_basic (unload) [138.484924] Starting subtest: unload [167.481158] Subtest unload: SUCCESS (28.940s) [167.536799] [155/162] (842s left) i915_module_load (reload) [167.601705] Starting subtest: reload [170.981135] Subtest reload: SUCCESS (3.380s) [171.077804] [156/162] (838s left) gem_lmem_swapping (basic) [171.332992] Subtest basic: SKIP (0.000s) [171.446392] [157/162] (838s left) gem_lmem_swapping (parallel-random-engines) [171.513081] Subtest parallel-random-engines: SKIP (0.000s) [171.570558] [158/162] (838s left) gem_lmem_swapping (random-engines) [171.637305] Subtest random-engines: SKIP (0.000s) [171.694380] [159/162] (838s left) gem_lmem_swapping (verify-random) [171.761666] Subtest verify-random: SKIP (0.000s) [171.820070] [160/162] (838s left) i915_pm_rpm (module-reload) [174.841853] Starting subtest: module-reload [189.120581] Subtest module-reload: SUCCESS (14.228s) [189.192738] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [189.194515] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [189.198780] [161/162] (820s left) i915_selftest (live) [189.270637] Starting subtest: live [189.271929] Starting dynamic subtest: sanitycheck [191.862312] Dynamic subtest sanitycheck: SUCCESS (2.535s) [191.874597] Starting dynamic subtest: uncore [194.384309] Dynamic subtest uncore: SUCCESS (2.521s) [194.396514] Starting dynamic subtest: workarounds [197.233539] Dynamic subtest workarounds: SUCCESS (2.848s) [197.245721] Starting dynamic subtest: gt_engines [200.307406] Dynamic subtest gt_engines: SUCCESS (3.073s) [200.319632] Starting dynamic subtest: gt_timelines [215.517404] Dynamic subtest gt_timelines: SUCCESS (15.209s) [215.529760] Starting dynamic subtest: gt_contexts [218.199415] Dynamic subtest gt_contexts: SUCCESS (2.681s) [218.211637] Starting dynamic subtest: gt_lrc [223.926218] Dynamic subtest gt_lrc: SUCCESS (5.726s) [223.941979] Starting dynamic subtest: gt_mocs [226.604107] Dynamic subtest gt_mocs: SUCCESS (2.677s) [226.616335] Starting dynamic subtest: gt_pm [237.740033] Dynamic subtest gt_pm: SUCCESS (11.135s) [237.752303] Starting dynamic subtest: gt_heartbeat [240.273063] Dynamic subtest gt_heartbeat: SUCCESS (2.532s) [240.285307] Starting dynamic subtest: gt_tlb [244.524167] Dynamic subtest gt_tlb: SUCCESS (4.250s) [244.539633] Starting dynamic subtest: requests [254.603743] Dynamic subtest requests: SUCCESS (10.078s) [254.616073] Starting dynamic subtest: migrate [260.069842] Dynamic subtest migrate: SUCCESS (5.465s) [260.082172] Starting dynamic subtest: active [262.635304] Dynamic subtest active: SUCCESS (2.564s) [262.647634] Starting dynamic subtest: objects [266.091606] Dynamic subtest objects: SUCCESS (3.455s) [266.106193] Starting dynamic subtest: mman [272.202048] Dynamic subtest mman: SUCCESS (6.109s) [272.218246] Starting dynamic subtest: dmabuf [274.835421] Dynamic subtest dmabuf: SUCCESS (2.631s) [274.851633] Starting dynamic subtest: vma [277.432573] Dynamic subtest vma: SUCCESS (2.595s) [277.444939] Starting dynamic subtest: coherency [281.220854] Dynamic subtest coherency: SUCCESS (3.786s) [281.237084] Starting dynamic subtest: gtt [291.105259] Dynamic subtest gtt: SUCCESS (9.883s) [291.117668] Starting dynamic subtest: gem [294.196499] Dynamic subtest gem: SUCCESS (3.089s) [294.208809] Starting dynamic subtest: evict [299.054241] Dynamic subtest evict: SUCCESS (4.856s) [299.066601] Starting dynamic subtest: hugepages [308.066357] Dynamic subtest hugepages: SUCCESS (9.010s) [308.082145] Starting dynamic subtest: gem_contexts [327.833024] Dynamic subtest gem_contexts: SUCCESS (19.765s) [327.845436] Starting dynamic subtest: client [330.414095] Dynamic subtest client: SUCCESS (2.579s) [330.426497] Starting dynamic subtest: gem_migrate [332.950617] Dynamic subtest gem_migrate: SUCCESS (2.534s) [332.963417] Starting dynamic subtest: reset [335.912123] Dynamic subtest reset: SUCCESS (2.960s) [335.924479] Starting dynamic subtest: memory_region [338.442982] Dynamic subtest memory_region: SUCCESS (2.529s) [338.455371] Starting dynamic subtest: hangcheck [369.720045] Dynamic subtest hangcheck: SUCCESS (31.275s) [369.732458] Starting dynamic subtest: execlists [385.129463] Dynamic subtest execlists: SUCCESS (15.407s) [385.142132] Starting dynamic subtest: ring_submission [387.663198] Dynamic subtest ring_submission: SUCCESS (2.532s) [387.675611] Starting dynamic subtest: perf [390.301832] Dynamic subtest perf: SUCCESS (2.637s) [390.314308] Starting dynamic subtest: slpc [392.833247] Dynamic subtest slpc: SUCCESS (2.529s) [392.847643] Starting dynamic subtest: guc [395.353525] Dynamic subtest guc: SUCCESS (2.518s) [395.365958] Starting dynamic subtest: guc_multi_lrc [397.915223] Dynamic subtest guc_multi_lrc: SUCCESS (2.560s) [397.927640] Starting dynamic subtest: guc_hang [400.452217] Dynamic subtest guc_hang: SUCCESS (2.535s) [400.465702] Starting dynamic subtest: late_gt_pm [403.015750] Dynamic subtest late_gt_pm: SUCCESS (2.561s) [403.017955] Subtest live: SUCCESS (213.687s) [403.088170] [162/162] (607s left) dmabuf (all-tests) [403.156518] Starting subtest: all-tests [403.158761] Subtest all-tests: SKIP (0.000s) [403.201368] 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: core_debugfs results: parsing output: 3/ for test: core_sysfs results: parsing output: 4/ for test: fbdev 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: gem_basic results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_busy results: parsing output: 13/ for test: gem_close_race results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_ctx_create results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_exec results: parsing output: 18/ for test: gem_exec_basic results: parsing output: 19/ for test: gem_exec_create results: parsing output: 20/ for test: gem_exec_fence 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_gttfill results: parsing output: 25/ for test: gem_exec_parallel results: parsing output: 26/ for test: gem_exec_store results: parsing output: 27/ for test: gem_flink_basic 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_huc_copy results: parsing output: 33/ for test: gem_linear_blits results: parsing output: 34/ for test: gem_mmap results: parsing output: 35/ for test: gem_mmap_gtt results: parsing output: 36/ for test: gem_render_linear_blits results: parsing output: 37/ for test: gem_render_tiled_blits results: parsing output: 38/ for test: gem_ringfill results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_sync results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_tiled_blits results: parsing output: 45/ for test: gem_tiled_fence_blits results: parsing output: 46/ for test: gem_tiled_pread_basic results: parsing output: 47/ for test: gem_wait results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: i915_getparams_basic results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_hangman results: parsing output: 52/ for test: i915_pciid results: parsing output: 53/ for test: intel_hwmon results: parsing output: 54/ for test: intel_hwmon 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_addfb_basic results: parsing output: 93/ for test: kms_busy results: parsing output: 94/ for test: kms_prop_blob 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_cursor_legacy results: parsing output: 103/ for test: kms_dsc 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_flip 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_force_connector_basic results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: kms_hdmi_inject 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_pipe_crc_basic results: parsing output: 121/ for test: kms_pm_backlight results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_pm_rpm 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_psr results: parsing output: 128/ for test: kms_setmode results: parsing output: 129/ for test: i915_pm_rps 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_self_import 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: prime_vgem 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: vgem_basic results: parsing output: 152/ for test: core_hotunplug results: parsing output: 153/ for test: vgem_basic results: parsing output: 154/ for test: i915_module_load 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: gem_lmem_swapping results: parsing output: 159/ for test: i915_pm_rpm results: parsing output: 160/ for test: i915_selftest results: parsing output: 161/ for test: dmabuf Done.