[30.847204] Initializing watchdogs [30.847333] /dev/watchdog0 [30.873219] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [30.882918] [001/162] (960s left) i915_module_load (load) [30.951609] Starting subtest: load [33.595689] Subtest load: SUCCESS (2.644s) [33.638298] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [33.640451] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [33.643590] [002/162] (957s left) core_auth (basic-auth) [33.760199] Starting subtest: basic-auth [33.761478] Subtest basic-auth: SUCCESS (0.002s) [33.826467] [003/162] (957s left) core_debugfs (read-all-entries) [33.884579] Starting subtest: read-all-entries [33.887535] Subtest read-all-entries: SUCCESS (0.003s) [33.935855] [004/162] (957s left) core_sysfs (read-all-entries) [33.993976] Starting subtest: read-all-entries [33.997982] Subtest read-all-entries: SUCCESS (0.005s) [34.045016] [005/162] (957s left) fbdev (eof) [34.116348] Subtest eof: SKIP (0.000s) [34.162887] [006/162] (957s left) fbdev (info) [34.230768] Subtest info: SKIP (0.000s) [34.275814] [007/162] (957s left) fbdev (nullptr) [34.344283] Subtest nullptr: SKIP (0.000s) [34.389968] [008/162] (957s left) fbdev (read) [34.459196] Subtest read: SKIP (0.000s) [34.505308] [009/162] (957s left) fbdev (write) [34.573804] Subtest write: SKIP (0.000s) [34.619577] [010/162] (957s left) gem_basic (bad-close) [34.677912] Starting subtest: bad-close [34.679836] Subtest bad-close: SUCCESS (0.000s) [34.725641] [011/162] (957s left) gem_basic (create-close) [34.784332] Starting subtest: create-close [34.786206] Subtest create-close: SUCCESS (0.000s) [34.850483] [012/162] (957s left) gem_basic (create-fd-close) [34.909298] Starting subtest: create-fd-close [34.911129] Subtest create-fd-close: SUCCESS (0.000s) [34.977601] [013/162] (957s left) gem_busy (busy@all-engines) [35.056365] Starting subtest: busy [35.057284] Starting dynamic subtest: all-engines [35.115801] Dynamic subtest all-engines: SUCCESS (0.060s) [35.117061] Subtest busy: SUCCESS (0.061s) [35.509567] [014/162] (956s left) gem_close_race (basic-process) [35.587929] Starting subtest: basic-process [35.652961] Subtest basic-process: SUCCESS (0.065s) [35.893347] [015/162] (956s left) gem_close_race (basic-threads) [35.972629] Starting subtest: basic-threads [37.142037] Subtest basic-threads: SUCCESS (1.169s) [37.345732] [016/162] (954s left) gem_ctx_create (basic) [37.428888] Starting subtest: basic [37.430226] Subtest basic: SUCCESS (0.000s) [37.614213] [017/162] (954s left) gem_ctx_create (basic-files) [37.930216] Starting subtest: basic-files [39.949785] Subtest basic-files: SUCCESS (2.020s) [40.166269] [018/162] (952s left) gem_ctx_exec (basic) [40.227452] Starting subtest: basic [40.234111] Subtest basic: SUCCESS (0.007s) [40.315161] [019/162] (952s left) gem_exec_basic (basic) [40.383029] Starting subtest: basic [40.384084] Starting dynamic subtest: rcs0-smem [40.387404] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [40.397561] Starting dynamic subtest: bcs0-smem [40.398487] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [40.407938] Starting dynamic subtest: vcs0-smem [40.409139] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [40.418478] Starting dynamic subtest: vcs1-smem [40.419596] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [40.428875] Starting dynamic subtest: vecs0-smem [40.430050] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [40.431134] Subtest basic: SUCCESS (0.012s) [40.592993] [020/162] (951s left) gem_exec_create (basic) [40.667035] Starting subtest: basic [40.668044] Starting dynamic subtest: smem [42.744119] Dynamic subtest smem: SUCCESS (2.038s) [42.745922] Subtest basic: SUCCESS (2.038s) [42.875559] [021/162] (949s left) gem_exec_fence (basic-busy) [43.083910] Starting subtest: basic-busy [43.085406] Starting dynamic subtest: rcs0 [43.115543] Dynamic subtest rcs0: SUCCESS (0.034s) [43.131755] Starting dynamic subtest: bcs0 [43.154599] Dynamic subtest bcs0: SUCCESS (0.039s) [43.171853] Starting dynamic subtest: vcs0 [43.178319] Dynamic subtest vcs0: SUCCESS (0.023s) [43.190528] Starting dynamic subtest: vcs1 [43.206413] Dynamic subtest vcs1: SUCCESS (0.028s) [43.216513] Starting dynamic subtest: vecs0 [43.231431] Dynamic subtest vecs0: SUCCESS (0.025s) [43.232873] Subtest basic-busy: SUCCESS (0.150s) [43.914820] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [43.917471] [022/162] (948s left) gem_exec_fence (basic-wait) [44.138760] Starting subtest: basic-wait [44.140513] Starting dynamic subtest: rcs0 [44.170393] Dynamic subtest rcs0: SUCCESS (0.032s) [44.182216] Starting dynamic subtest: bcs0 [44.196492] Dynamic subtest bcs0: SUCCESS (0.026s) [44.208204] Starting dynamic subtest: vcs0 [44.216427] Dynamic subtest vcs0: SUCCESS (0.020s) [44.227638] Starting dynamic subtest: vcs1 [44.237456] Dynamic subtest vcs1: SUCCESS (0.021s) [44.249076] Starting dynamic subtest: vecs0 [44.266374] Dynamic subtest vecs0: SUCCESS (0.028s) [44.267682] Subtest basic-wait: SUCCESS (0.127s) [44.890044] [023/162] (947s left) gem_exec_fence (basic-await) [45.113089] Starting subtest: basic-await [45.114378] Starting dynamic subtest: rcs0 [45.225162] Dynamic subtest rcs0: SUCCESS (0.107s) [45.241483] Starting dynamic subtest: bcs0 [45.330839] Dynamic subtest bcs0: SUCCESS (0.111s) [45.345157] Starting dynamic subtest: vcs0 [45.443997] Dynamic subtest vcs0: SUCCESS (0.113s) [45.458114] Starting dynamic subtest: vcs1 [45.560766] Dynamic subtest vcs1: SUCCESS (0.116s) [45.581478] Starting dynamic subtest: vecs0 [45.767832] Dynamic subtest vecs0: SUCCESS (0.150s) [45.770575] Subtest basic-await: SUCCESS (0.601s) [46.387124] [024/162] (946s left) gem_exec_fence (nb-await) [46.602602] Starting subtest: nb-await [46.604420] Starting dynamic subtest: rcs0 [46.679319] Dynamic subtest rcs0: SUCCESS (0.076s) [46.694769] Starting dynamic subtest: bcs0 [46.749151] Dynamic subtest bcs0: SUCCESS (0.068s) [46.778236] Starting dynamic subtest: vcs0 [46.834982] Dynamic subtest vcs0: SUCCESS (0.084s) [46.864027] Starting dynamic subtest: vcs1 [46.918616] Dynamic subtest vcs1: SUCCESS (0.082s) [46.946848] Starting dynamic subtest: vecs0 [47.001180] Dynamic subtest vecs0: SUCCESS (0.081s) [47.003228] Subtest nb-await: SUCCESS (0.398s) [47.697749] [025/162] (945s left) gem_exec_gttfill (basic) [47.778603] Starting subtest: basic [52.760300] Subtest basic: SUCCESS (4.981s) [53.019977] [026/162] (939s left) gem_exec_parallel (engines) [53.368457] Starting subtest: engines [53.369494] Starting dynamic subtest: basic [55.726366] Dynamic subtest basic: SUCCESS (2.312s) [55.737786] Starting dynamic subtest: contexts [59.059694] Dynamic subtest contexts: SUCCESS (3.323s) [59.071563] Starting dynamic subtest: fds [68.006995] Dynamic subtest fds: SUCCESS (9.002s) [68.021161] Starting dynamic subtest: userptr [70.587981] Dynamic subtest userptr: SUCCESS (2.535s) [70.589852] Subtest engines: SUCCESS (17.175s) [70.763098] [027/162] (922s left) gem_exec_store (basic) [70.849569] Starting subtest: basic [70.901626] Subtest basic: SUCCESS (0.052s) [71.122308] [028/162] (921s left) gem_flink_basic (bad-flink) [71.182251] Starting subtest: bad-flink [71.183373] Subtest bad-flink: SUCCESS (0.000s) [71.236457] [029/162] (921s left) gem_flink_basic (bad-open) [71.295538] Starting subtest: bad-open [71.296651] Subtest bad-open: SUCCESS (0.000s) [71.349199] [030/162] (921s left) gem_flink_basic (basic) [71.629182] Starting subtest: basic [71.631358] Subtest basic: SUCCESS (0.001s) [71.723934] [031/162] (921s left) gem_flink_basic (double-flink) [71.780187] Starting subtest: double-flink [71.781063] Subtest double-flink: SUCCESS (0.000s) [71.853188] [032/162] (921s left) gem_flink_basic (flink-lifetime) [71.910875] Starting subtest: flink-lifetime [71.912958] Subtest flink-lifetime: SUCCESS (0.002s) [71.987350] [033/162] (921s left) gem_huc_copy (huc-copy) [72.054687] Starting subtest: huc-copy [72.056711] Subtest huc-copy: SKIP (0.000s) [72.137776] [034/162] (921s left) gem_linear_blits (basic) [72.321476] Starting subtest: basic [72.333872] Subtest basic: SUCCESS (0.010s) [72.431744] [035/162] (921s left) gem_mmap (basic) [72.643249] Starting subtest: basic [72.648298] Subtest basic: SUCCESS (0.001s) [72.726485] [036/162] (920s left) gem_mmap_gtt (basic) [72.786244] Starting subtest: basic [72.787140] Subtest basic: SUCCESS (0.001s) [72.843514] [037/162] (920s left) gem_render_linear_blits (basic) [72.915424] Starting subtest: basic [72.948561] Subtest basic: SUCCESS (0.033s) [73.016800] [038/162] (920s left) gem_render_tiled_blits (basic) [73.083072] Starting subtest: basic [73.124818] Subtest basic: SUCCESS (0.041s) [73.195475] [039/162] (920s left) gem_ringfill (basic-all) [73.488210] Starting subtest: basic-all [74.670751] Subtest basic-all: SUCCESS (1.178s) [74.747311] [040/162] (919s left) gem_softpin (allocator-basic) [74.824579] Starting subtest: allocator-basic [75.040517] Subtest allocator-basic: SUCCESS (0.161s) [75.099680] [041/162] (918s left) gem_softpin (allocator-basic-reserve) [75.178305] Starting subtest: allocator-basic-reserve [75.383746] Subtest allocator-basic-reserve: SUCCESS (0.149s) [75.437600] [042/162] (918s left) gem_softpin (safe-alignment) [75.512902] Starting subtest: safe-alignment [75.531693] Subtest safe-alignment: SUCCESS (0.019s) [75.618237] [043/162] (918s left) gem_sync (basic-all) [75.699311] Starting subtest: basic-all [78.261154] Subtest basic-all: SUCCESS (2.561s) [78.479231] [044/162] (915s left) gem_sync (basic-each) [78.557442] Starting subtest: basic-each [80.821753] Subtest basic-each: SUCCESS (2.264s) [81.121874] [045/162] (913s left) gem_tiled_blits (basic) [81.282754] Starting subtest: basic [81.300472] Subtest basic: SUCCESS (0.019s) [81.416569] [046/162] (912s left) gem_tiled_fence_blits (basic) [81.974704] Starting subtest: basic [81.985824] Subtest basic: SUCCESS (0.011s) [82.098528] [047/162] (912s left) gem_tiled_pread_basic (basic) [82.273613] Starting subtest: basic [82.459065] Subtest basic: SUCCESS (0.130s) [82.520560] [048/162] (911s left) gem_wait (busy@all-engines) [82.613593] Starting subtest: busy [82.614684] Starting dynamic subtest: all-engines [83.182365] Dynamic subtest all-engines: SUCCESS (0.522s) [83.184315] Subtest busy: SUCCESS (0.522s) [83.364818] [049/162] (911s left) gem_wait (wait@all-engines) [83.449168] Starting subtest: wait [83.450374] Starting dynamic subtest: all-engines [84.550168] Dynamic subtest all-engines: SUCCESS (1.099s) [84.552332] Subtest wait: SUCCESS (1.101s) [84.853310] [050/162] (909s left) i915_getparams_basic (basic-eu-total) [84.919321] Starting subtest: basic-eu-total [84.921407] Subtest basic-eu-total: SUCCESS (0.000s) [84.973960] [051/162] (909s left) i915_getparams_basic (basic-subslice-total) [85.030976] Starting subtest: basic-subslice-total [85.033813] Subtest basic-subslice-total: SUCCESS (0.000s) [85.098306] [052/162] (909s left) i915_hangman (error-state-basic) [85.179529] Starting subtest: error-state-basic [85.187336] Subtest error-state-basic: SUCCESS (0.008s) [85.334954] [053/162] (909s left) i915_pciid [85.555210] [054/162] (909s left) intel_hwmon (hwmon-read) [85.614126] Subtest hwmon-read: SKIP (0.000s) [85.668991] [055/162] (909s left) intel_hwmon (hwmon-write) [85.727362] Subtest hwmon-write: SKIP (0.000s) [85.783424] [056/162] (909s left) kms_addfb_basic (addfb25-4-tiled) [86.128384] Starting subtest: addfb25-4-tiled [86.130368] Subtest addfb25-4-tiled: SUCCESS (0.001s) [86.228140] [057/162] (908s left) kms_addfb_basic (addfb25-bad-modifier) [86.507699] Starting subtest: addfb25-bad-modifier [86.511450] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [86.586304] [058/162] (908s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [86.858638] Starting subtest: addfb25-framebuffer-vs-set-tiling [86.859838] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [86.942324] [059/162] (908s left) kms_addfb_basic (addfb25-modifier-no-flag) [87.224549] Starting subtest: addfb25-modifier-no-flag [87.225881] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [87.321254] [060/162] (907s left) kms_addfb_basic (addfb25-x-tiled-legacy) [87.600314] Starting subtest: addfb25-x-tiled-legacy [87.601919] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [87.687779] [061/162] (907s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [87.959731] Starting subtest: addfb25-x-tiled-mismatch-legacy [87.960991] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [88.053906] [062/162] (907s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [88.321697] Starting subtest: addfb25-yf-tiled-legacy [88.322958] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [88.407381] [063/162] (907s left) kms_addfb_basic (addfb25-y-tiled-legacy) [88.683876] Starting subtest: addfb25-y-tiled-legacy [88.685203] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [88.769469] [064/162] (906s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [89.049231] Starting subtest: addfb25-y-tiled-small-legacy [89.050675] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [89.143241] [065/162] (906s left) kms_addfb_basic (bad-pitch-0) [89.201464] Starting subtest: bad-pitch-0 [89.202464] Subtest bad-pitch-0: SUCCESS (0.000s) [89.491069] [066/162] (906s left) kms_addfb_basic (bad-pitch-1024) [89.551083] Starting subtest: bad-pitch-1024 [89.552026] Subtest bad-pitch-1024: SUCCESS (0.000s) [89.852126] [067/162] (905s left) kms_addfb_basic (bad-pitch-128) [89.910543] Starting subtest: bad-pitch-128 [89.911540] Subtest bad-pitch-128: SUCCESS (0.000s) [90.218234] [068/162] (905s left) kms_addfb_basic (bad-pitch-256) [90.276161] Starting subtest: bad-pitch-256 [90.277204] Subtest bad-pitch-256: SUCCESS (0.000s) [90.583079] [069/162] (905s left) kms_addfb_basic (bad-pitch-32) [90.641490] Starting subtest: bad-pitch-32 [90.642406] Subtest bad-pitch-32: SUCCESS (0.000s) [90.929890] [070/162] (905s left) kms_addfb_basic (bad-pitch-63) [90.987288] Starting subtest: bad-pitch-63 [90.988266] Subtest bad-pitch-63: SUCCESS (0.000s) [91.290068] [071/162] (904s left) kms_addfb_basic (bad-pitch-65536) [91.349666] Starting subtest: bad-pitch-65536 [91.350622] Subtest bad-pitch-65536: SUCCESS (0.000s) [91.647604] [072/162] (904s left) kms_addfb_basic (bad-pitch-999) [91.708103] Starting subtest: bad-pitch-999 [91.708997] Subtest bad-pitch-999: SUCCESS (0.000s) [92.022412] [073/162] (904s left) kms_addfb_basic (basic) [92.079940] Starting subtest: basic [92.080950] Subtest basic: SUCCESS (0.000s) [92.377513] [074/162] (903s left) kms_addfb_basic (basic-x-tiled-legacy) [92.436204] Starting subtest: basic-x-tiled-legacy [92.437113] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [92.736163] [075/162] (903s left) kms_addfb_basic (basic-y-tiled-legacy) [92.796420] Starting subtest: basic-y-tiled-legacy [92.797371] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [93.105287] [076/162] (903s left) kms_addfb_basic (bo-too-small) [93.392714] Starting subtest: bo-too-small [93.393906] Subtest bo-too-small: SUCCESS (0.001s) [93.481206] [077/162] (902s left) kms_addfb_basic (bo-too-small-due-to-tiling) [93.759802] Starting subtest: bo-too-small-due-to-tiling [93.761023] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [93.846732] [078/162] (902s left) kms_addfb_basic (clobberred-modifier) [93.906916] Starting subtest: clobberred-modifier [93.908420] Subtest clobberred-modifier: SUCCESS (0.000s) [94.213176] [079/162] (902s left) kms_addfb_basic (framebuffer-vs-set-tiling) [94.273972] Starting subtest: framebuffer-vs-set-tiling [94.275027] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [94.588696] [080/162] (902s left) kms_addfb_basic (invalid-get-prop) [94.648326] Starting subtest: invalid-get-prop [94.649244] Subtest invalid-get-prop: SUCCESS (0.000s) [94.940817] [081/162] (901s left) kms_addfb_basic (invalid-get-prop-any) [94.998940] Starting subtest: invalid-get-prop-any [95.000378] Subtest invalid-get-prop-any: SUCCESS (0.000s) [95.328832] [082/162] (901s left) kms_addfb_basic (invalid-set-prop) [95.388204] Starting subtest: invalid-set-prop [95.389208] Subtest invalid-set-prop: SUCCESS (0.000s) [95.683140] [083/162] (901s left) kms_addfb_basic (invalid-set-prop-any) [95.742998] Starting subtest: invalid-set-prop-any [95.743985] Subtest invalid-set-prop-any: SUCCESS (0.000s) [96.045245] [084/162] (900s left) kms_addfb_basic (no-handle) [96.104064] Starting subtest: no-handle [96.105566] Subtest no-handle: SUCCESS (0.000s) [96.413065] [085/162] (900s left) kms_addfb_basic (size-max) [96.695251] Starting subtest: size-max [96.696375] Subtest size-max: SUCCESS (0.000s) [96.785756] [086/162] (900s left) kms_addfb_basic (small-bo) [97.057977] Starting subtest: small-bo [97.059431] Subtest small-bo: SUCCESS (0.000s) [97.145778] [087/162] (899s left) kms_addfb_basic (tile-pitch-mismatch) [97.203144] Starting subtest: tile-pitch-mismatch [97.204144] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [97.513443] [088/162] (899s left) kms_addfb_basic (too-high) [97.782687] Starting subtest: too-high [97.784226] Subtest too-high: SUCCESS (0.002s) [97.871640] [089/162] (899s left) kms_addfb_basic (too-wide) [98.159969] Starting subtest: too-wide [98.161386] Subtest too-wide: SUCCESS (0.000s) [98.240805] [090/162] (899s left) kms_addfb_basic (unused-handle) [98.300931] Starting subtest: unused-handle [98.301866] Subtest unused-handle: SUCCESS (0.000s) [98.583580] [091/162] (898s left) kms_addfb_basic (unused-modifier) [98.641483] Starting subtest: unused-modifier [98.642443] Subtest unused-modifier: SUCCESS (0.000s) [98.951106] [092/162] (898s left) kms_addfb_basic (unused-offsets) [99.008516] Starting subtest: unused-offsets [99.009470] Subtest unused-offsets: SUCCESS (0.000s) [99.304111] [093/162] (898s left) kms_addfb_basic (unused-pitches) [99.362120] Starting subtest: unused-pitches [99.363125] Subtest unused-pitches: SUCCESS (0.000s) [99.683623] [094/162] (897s left) kms_busy (basic) [99.966099] Subtest basic: SKIP (0.000s) [100.038149] [095/162] (897s left) kms_prop_blob (basic) [100.098308] Starting subtest: basic [100.099233] Subtest basic: SUCCESS (0.000s) [100.153098] [096/162] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [100.435016] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [100.495832] [097/162] (897s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [100.773167] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [100.831107] [098/162] (897s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [101.109762] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [101.166461] [099/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [101.449218] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [101.510042] [100/162] (896s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [101.786976] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [101.844951] [101/162] (896s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [102.132853] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [102.201123] [102/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [102.485866] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [102.547084] [103/162] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [102.828447] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [102.889094] [104/162] (895s left) kms_dsc (dsc-basic) [103.165226] Subtest dsc-basic: SKIP (0.000s) [103.241395] [105/162] (895s left) kms_flip (basic-flip-vs-dpms) [103.518788] Starting subtest: basic-flip-vs-dpms [103.522574] Subtest basic-flip-vs-dpms: SKIP (0.003s) [103.598734] [106/162] (894s left) kms_flip (basic-flip-vs-modeset) [103.868124] Starting subtest: basic-flip-vs-modeset [103.874538] Subtest basic-flip-vs-modeset: SKIP (0.004s) [103.964150] [107/162] (894s left) kms_flip (basic-flip-vs-wf_vblank) [104.233269] Starting subtest: basic-flip-vs-wf_vblank [104.237157] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [104.315989] [108/162] (894s left) kms_flip (basic-plain-flip) [104.589193] Starting subtest: basic-plain-flip [104.596029] Subtest basic-plain-flip: SKIP (0.002s) [104.669101] [109/162] (893s left) kms_force_connector_basic (force-connector-state) [105.056344] Starting subtest: force-connector-state [105.873538] Subtest force-connector-state: SUCCESS (0.817s) [106.482060] [110/162] (892s left) kms_force_connector_basic (force-edid) [106.873563] Starting subtest: force-edid [107.517396] Subtest force-edid: SUCCESS (0.643s) [108.028829] [111/162] (890s left) kms_force_connector_basic (force-load-detect) [108.421654] Starting subtest: force-load-detect [108.423920] Subtest force-load-detect: SKIP (0.000s) [108.811088] [112/162] (889s left) kms_force_connector_basic (prune-stale-modes) [109.200575] Starting subtest: prune-stale-modes [109.941079] Subtest prune-stale-modes: SUCCESS (0.741s) [110.440814] [113/162] (888s left) kms_frontbuffer_tracking (basic) [110.709538] Subtest basic: SKIP (0.000s) [110.795674] [114/162] (888s left) kms_hdmi_inject (inject-audio) [110.858298] Starting subtest: inject-audio [111.487086] Subtest inject-audio: SUCCESS (0.627s) [111.758958] [115/162] (887s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [112.037720] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [112.106531] [116/162] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [112.383188] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [112.449784] [117/162] (886s left) kms_pipe_crc_basic (hang-read-crc) [112.724053] Subtest hang-read-crc: SKIP (0.000s) [112.796516] [118/162] (886s left) kms_pipe_crc_basic (nonblocking-crc) [113.066925] Subtest nonblocking-crc: SKIP (0.000s) [113.136777] [119/162] (886s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [113.409442] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [113.481403] [120/162] (885s left) kms_pipe_crc_basic (read-crc) [113.751148] Subtest read-crc: SKIP (0.000s) [113.828632] [121/162] (885s left) kms_pipe_crc_basic (read-crc-frame-sequence) [114.103973] Subtest read-crc-frame-sequence: SKIP (0.000s) [114.175975] [122/162] (885s left) kms_pm_backlight (basic-brightness) [114.451581] Subtest basic-brightness: SKIP (0.000s) [114.528354] [123/162] (884s left) kms_pm_rpm (basic-pci-d3-state) [116.168446] Starting subtest: basic-pci-d3-state [116.485762] Subtest basic-pci-d3-state: SUCCESS (0.318s) [116.661467] [124/162] (882s left) kms_pm_rpm (basic-rte) [116.890012] Starting subtest: basic-rte [118.729153] Subtest basic-rte: SUCCESS (1.924s) [119.220873] [125/162] (880s left) kms_psr (psr-primary-page-flip) [119.601383] Subtest psr-primary-page-flip: SKIP (0.000s) [119.669015] [126/162] (879s left) kms_psr (psr-cursor-plane-move) [119.942989] Subtest psr-cursor-plane-move: SKIP (0.000s) [120.017969] [127/162] (879s left) kms_psr (psr-sprite-plane-onoff) [120.294695] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [120.368482] [128/162] (879s left) kms_psr (psr-primary-mmap-gtt) [120.640338] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [120.713845] [129/162] (879s left) kms_setmode (basic-clone-single-crtc) [120.773415] Starting subtest: basic-clone-single-crtc [120.775994] Subtest basic-clone-single-crtc: SKIP (0.000s) [120.841804] [130/162] (879s left) i915_pm_rps (basic-api) [120.914220] Starting subtest: basic-api [120.917686] Subtest basic-api: SUCCESS (0.005s) [120.978963] [131/162] (878s left) prime_self_import (basic-llseek-bad) [121.039952] Starting subtest: basic-llseek-bad [121.041933] Subtest basic-llseek-bad: SUCCESS (0.003s) [121.116393] [132/162] (878s left) prime_self_import (basic-llseek-size) [121.172960] Starting subtest: basic-llseek-size [121.177911] Subtest basic-llseek-size: SUCCESS (0.004s) [121.266369] [133/162] (878s left) prime_self_import (basic-with_fd_dup) [121.321340] Starting subtest: basic-with_fd_dup [121.326888] Subtest basic-with_fd_dup: SUCCESS (0.004s) [121.409454] [134/162] (878s left) prime_self_import (basic-with_one_bo) [121.466463] Starting subtest: basic-with_one_bo [121.469941] Subtest basic-with_one_bo: SUCCESS (0.004s) [121.533618] [135/162] (878s left) prime_self_import (basic-with_one_bo_two_files) [121.587963] Starting subtest: basic-with_one_bo_two_files [121.592444] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [121.676682] [136/162] (878s left) prime_self_import (basic-with_two_bos) [121.730565] Starting subtest: basic-with_two_bos [121.735181] Subtest basic-with_two_bos: SUCCESS (0.005s) [121.812799] [137/162] (878s left) prime_vgem (basic-fence-flip) [121.882260] Starting subtest: basic-fence-flip [122.094205] Subtest basic-fence-flip: SKIP (0.209s) [122.172873] [138/162] (878s left) prime_vgem (basic-fence-mmap) [122.240437] Starting subtest: basic-fence-mmap [122.272118] Subtest basic-fence-mmap: SUCCESS (0.032s) [122.368286] [139/162] (878s left) prime_vgem (basic-fence-read) [122.436852] Starting subtest: basic-fence-read [122.506946] Subtest basic-fence-read: SUCCESS (0.070s) [122.573041] [140/162] (877s left) prime_vgem (basic-gtt) [122.640502] Starting subtest: basic-gtt [122.655209] Subtest basic-gtt: SUCCESS (0.015s) [122.739614] [141/162] (877s left) prime_vgem (basic-read) [122.810195] Starting subtest: basic-read [122.842783] Subtest basic-read: SUCCESS (0.033s) [122.932280] [142/162] (877s left) prime_vgem (basic-write) [123.001107] Starting subtest: basic-write [123.037161] Subtest basic-write: SUCCESS (0.036s) [123.108319] [143/162] (877s left) vgem_basic (setversion) [123.172347] Starting subtest: setversion [123.174174] Subtest setversion: SUCCESS (0.000s) [123.243332] [144/162] (877s left) vgem_basic (create) [123.304934] Starting subtest: create [123.305867] Subtest create: SUCCESS (0.000s) [123.362455] [145/162] (877s left) vgem_basic (debugfs) [123.422894] Starting subtest: debugfs [123.423920] Subtest debugfs: SUCCESS (0.000s) [123.482607] [146/162] (877s left) vgem_basic (dmabuf-export) [123.542485] Starting subtest: dmabuf-export [123.544340] Subtest dmabuf-export: SUCCESS (0.003s) [123.622490] [147/162] (877s left) vgem_basic (dmabuf-fence) [123.682278] Starting subtest: dmabuf-fence [123.683197] Subtest dmabuf-fence: SUCCESS (0.002s) [123.744929] [148/162] (877s left) vgem_basic (dmabuf-fence-before) [123.805755] Starting subtest: dmabuf-fence-before [123.807332] Subtest dmabuf-fence-before: SUCCESS (0.000s) [123.863010] [149/162] (877s left) vgem_basic (dmabuf-mmap) [123.922933] Starting subtest: dmabuf-mmap [123.936535] Subtest dmabuf-mmap: SUCCESS (0.015s) [124.003206] [150/162] (877s left) vgem_basic (mmap) [124.064051] Starting subtest: mmap [124.071518] Subtest mmap: SUCCESS (0.009s) [124.130994] [151/162] (877s left) vgem_basic (second-client) [124.192092] Starting subtest: second-client [124.194946] Subtest second-client: SUCCESS (0.004s) [124.257395] [152/162] (876s left) vgem_basic (sysfs) [124.317723] Starting subtest: sysfs [124.318692] Subtest sysfs: SUCCESS (0.001s) [124.375746] [153/162] (876s left) core_hotunplug (unbind-rebind) [124.485421] Starting subtest: unbind-rebind [128.921353] Subtest unbind-rebind: SUCCESS (4.432s) [128.978747] [154/162] (872s left) vgem_basic (unload) [129.043806] Starting subtest: unload [158.016060] Subtest unload: SUCCESS (28.920s) [158.071549] [155/162] (843s left) i915_module_load (reload) [158.133865] Starting subtest: reload [161.857182] Subtest reload: SUCCESS (3.723s) [161.946590] [156/162] (839s left) gem_lmem_swapping (basic) [162.074018] Subtest basic: SKIP (0.000s) [162.162153] [157/162] (839s left) gem_lmem_swapping (parallel-random-engines) [162.228830] Subtest parallel-random-engines: SKIP (0.000s) [162.283089] [158/162] (839s left) gem_lmem_swapping (random-engines) [162.348175] Subtest random-engines: SKIP (0.000s) [162.405930] [159/162] (839s left) gem_lmem_swapping (verify-random) [162.472062] Subtest verify-random: SKIP (0.000s) [162.527549] [160/162] (839s left) i915_pm_rpm (module-reload) [165.519889] Starting subtest: module-reload [180.712293] Subtest module-reload: SUCCESS (15.139s) [180.777538] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [180.779060] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [180.781532] [161/162] (821s left) i915_selftest (live) [180.850735] Starting subtest: live [180.851919] Starting dynamic subtest: sanitycheck [183.837833] Dynamic subtest sanitycheck: SUCCESS (2.931s) [183.851623] Starting dynamic subtest: uncore [186.779908] Dynamic subtest uncore: SUCCESS (2.941s) [186.790612] Starting dynamic subtest: workarounds [190.014599] Dynamic subtest workarounds: SUCCESS (3.234s) [190.025357] Starting dynamic subtest: gt_engines [193.434885] Dynamic subtest gt_engines: SUCCESS (3.419s) [193.448621] Starting dynamic subtest: gt_timelines [208.427851] Dynamic subtest gt_timelines: SUCCESS (14.992s) [208.438600] Starting dynamic subtest: gt_contexts [211.536521] Dynamic subtest gt_contexts: SUCCESS (3.108s) [211.548607] Starting dynamic subtest: gt_lrc [217.572256] Dynamic subtest gt_lrc: SUCCESS (6.034s) [217.583188] Starting dynamic subtest: gt_mocs [220.599886] Dynamic subtest gt_mocs: SUCCESS (3.026s) [220.610782] Starting dynamic subtest: gt_pm [232.187066] Dynamic subtest gt_pm: SUCCESS (11.586s) [232.197984] Starting dynamic subtest: gt_heartbeat [235.098018] Dynamic subtest gt_heartbeat: SUCCESS (2.910s) [235.108911] Starting dynamic subtest: gt_tlb [239.601051] Dynamic subtest gt_tlb: SUCCESS (4.502s) [239.615008] Starting dynamic subtest: requests [249.993247] Dynamic subtest requests: SUCCESS (10.391s) [250.004142] Starting dynamic subtest: migrate [255.896822] Dynamic subtest migrate: SUCCESS (5.902s) [255.910807] Starting dynamic subtest: active [258.825845] Dynamic subtest active: SUCCESS (2.928s) [258.836837] Starting dynamic subtest: objects [262.590628] Dynamic subtest objects: SUCCESS (3.763s) [262.601529] Starting dynamic subtest: mman [269.050650] Dynamic subtest mman: SUCCESS (6.459s) [269.064623] Starting dynamic subtest: dmabuf [271.998591] Dynamic subtest dmabuf: SUCCESS (2.946s) [272.009484] Starting dynamic subtest: vma [274.947725] Dynamic subtest vma: SUCCESS (2.948s) [274.958628] Starting dynamic subtest: coherency [279.138716] Dynamic subtest coherency: SUCCESS (4.189s) [279.152649] Starting dynamic subtest: gtt [289.362088] Dynamic subtest gtt: SUCCESS (10.221s) [289.373016] Starting dynamic subtest: gem [292.819664] Dynamic subtest gem: SUCCESS (3.456s) [292.833731] Starting dynamic subtest: evict [298.053990] Dynamic subtest evict: SUCCESS (5.232s) [298.067999] Starting dynamic subtest: hugepages [307.492959] Dynamic subtest hugepages: SUCCESS (9.437s) [307.504026] Starting dynamic subtest: gem_contexts [327.665967] Dynamic subtest gem_contexts: SUCCESS (20.171s) [327.676933] Starting dynamic subtest: client [330.633347] Dynamic subtest client: SUCCESS (2.965s) [330.647939] Starting dynamic subtest: gem_migrate [333.581070] Dynamic subtest gem_migrate: SUCCESS (2.946s) [333.592048] Starting dynamic subtest: reset [336.904922] Dynamic subtest reset: SUCCESS (3.322s) [336.919480] Starting dynamic subtest: memory_region [339.745285] Dynamic subtest memory_region: SUCCESS (2.894s) [339.763266] Starting dynamic subtest: hangcheck [371.412570] Dynamic subtest hangcheck: SUCCESS (31.609s) [371.423537] Starting dynamic subtest: execlists [387.278066] Dynamic subtest execlists: SUCCESS (15.863s) [387.289018] Starting dynamic subtest: ring_submission [390.193867] Dynamic subtest ring_submission: SUCCESS (2.914s) [390.204908] Starting dynamic subtest: perf [393.194292] Dynamic subtest perf: SUCCESS (3.005s) [393.208613] Starting dynamic subtest: slpc [396.078726] Dynamic subtest slpc: SUCCESS (2.931s) [396.091997] Starting dynamic subtest: guc [399.042875] Dynamic subtest guc: SUCCESS (2.907s) [399.053847] Starting dynamic subtest: guc_multi_lrc [401.942010] Dynamic subtest guc_multi_lrc: SUCCESS (2.897s) [401.953017] Starting dynamic subtest: guc_hang [404.880956] Dynamic subtest guc_hang: SUCCESS (2.937s) [404.895081] Starting dynamic subtest: late_gt_pm [407.843563] Dynamic subtest late_gt_pm: SUCCESS (2.960s) [407.845976] Subtest live: SUCCESS (226.933s) [407.912884] [162/162] (594s left) dmabuf (all-tests) [407.987605] Starting subtest: all-tests [407.989105] Starting dynamic subtest: sanitycheck [408.056277] Dynamic subtest sanitycheck: SUCCESS (0.067s) [408.097065] Starting dynamic subtest: dma_fence [408.241691] Dynamic subtest dma_fence: SUCCESS (0.179s) [408.258774] Starting dynamic subtest: dma_fence_chain [408.262248] Dynamic subtest dma_fence_chain: SKIP (0.000s) [408.276607] Starting dynamic subtest: dma_fence_unwrap [408.306664] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s) [408.325347] Starting dynamic subtest: dma_resv [408.365826] Dynamic subtest dma_resv: SUCCESS (0.056s) [408.371250] Subtest all-tests: SUCCESS (0.380s) [408.440108] 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.