[78.506837] Initializing watchdogs [78.506955] /dev/watchdog0 [78.531347] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [78.537951] [001/162] (960s left) i915_module_load (load) [78.605206] Starting subtest: load [80.881026] Subtest load: SUCCESS (2.284s) [80.929956] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [80.932109] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [80.935458] [002/162] (958s left) core_auth (basic-auth) [81.016237] Starting subtest: basic-auth [81.017210] Subtest basic-auth: SUCCESS (0.001s) [81.063875] [003/162] (958s left) core_debugfs (read-all-entries) [81.121178] Starting subtest: read-all-entries [81.123898] Subtest read-all-entries: SUCCESS (0.003s) [81.172109] [004/162] (958s left) core_sysfs (read-all-entries) [81.232078] Starting subtest: read-all-entries [81.234879] Subtest read-all-entries: SUCCESS (0.005s) [81.284327] [005/162] (957s left) fbdev (eof) [81.353448] Subtest eof: SKIP (0.000s) [81.398031] [006/162] (957s left) fbdev (info) [81.465276] Subtest info: SKIP (0.000s) [81.511762] [007/162] (957s left) fbdev (nullptr) [81.578672] Subtest nullptr: SKIP (0.000s) [81.623197] [008/162] (957s left) fbdev (read) [81.689753] Subtest read: SKIP (0.000s) [81.734650] [009/162] (957s left) fbdev (write) [81.803661] Subtest write: SKIP (0.000s) [81.847711] [010/162] (957s left) gem_basic (bad-close) [81.904052] Starting subtest: bad-close [81.905874] Subtest bad-close: SUCCESS (0.000s) [81.952147] [011/162] (957s left) gem_basic (create-close) [82.009238] Starting subtest: create-close [82.011075] Subtest create-close: SUCCESS (0.000s) [82.077287] [012/162] (957s left) gem_basic (create-fd-close) [82.134139] Starting subtest: create-fd-close [82.135806] Subtest create-fd-close: SUCCESS (0.000s) [82.195369] [013/162] (957s left) gem_busy (busy@all-engines) [82.273446] Starting subtest: busy [82.274430] Starting dynamic subtest: all-engines [82.343324] Dynamic subtest all-engines: SUCCESS (0.070s) [82.344805] Subtest busy: SUCCESS (0.070s) [82.735022] [014/162] (956s left) gem_close_race (basic-process) [82.815835] Starting subtest: basic-process [82.889027] Subtest basic-process: SUCCESS (0.073s) [83.128690] [015/162] (956s left) gem_close_race (basic-threads) [83.207200] Starting subtest: basic-threads [84.419054] Subtest basic-threads: SUCCESS (1.214s) [84.609639] [016/162] (955s left) gem_ctx_create (basic) [84.683906] Starting subtest: basic [84.685099] Subtest basic: SUCCESS (0.000s) [84.873786] [017/162] (955s left) gem_ctx_create (basic-files) [85.139110] Starting subtest: basic-files [87.121240] Subtest basic-files: SUCCESS (2.020s) [87.349238] [018/162] (952s left) gem_ctx_exec (basic) [87.414067] Starting subtest: basic [87.417329] Subtest basic: SUCCESS (0.005s) [87.500811] [019/162] (952s left) gem_exec_basic (basic) [87.571082] Starting subtest: basic [87.572239] Starting dynamic subtest: rcs0-smem [87.574908] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [87.584946] Starting dynamic subtest: bcs0-smem [87.586212] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [87.595510] Starting dynamic subtest: vcs0-smem [87.596823] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [87.606358] Starting dynamic subtest: vcs1-smem [87.607713] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [87.616867] Starting dynamic subtest: vecs0-smem [87.618183] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [87.619449] Subtest basic: SUCCESS (0.011s) [87.794698] [020/162] (952s left) gem_exec_create (basic) [87.871544] Starting subtest: basic [87.872596] Starting dynamic subtest: smem [89.956944] Dynamic subtest smem: SUCCESS (2.050s) [89.958485] Subtest basic: SUCCESS (2.050s) [90.096411] [021/162] (950s left) gem_exec_fence (basic-busy) [90.330180] Starting subtest: basic-busy [90.331528] Starting dynamic subtest: rcs0 [90.358405] Dynamic subtest rcs0: SUCCESS (0.030s) [90.370082] Starting dynamic subtest: bcs0 [90.387389] Dynamic subtest bcs0: SUCCESS (0.028s) [90.398355] Starting dynamic subtest: vcs0 [90.418436] Dynamic subtest vcs0: SUCCESS (0.032s) [90.429940] Starting dynamic subtest: vcs1 [90.445723] Dynamic subtest vcs1: SUCCESS (0.027s) [90.456927] Starting dynamic subtest: vecs0 [90.470430] Dynamic subtest vecs0: SUCCESS (0.024s) [90.471777] Subtest basic-busy: SUCCESS (0.142s) [91.162747] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [91.165246] [022/162] (949s left) gem_exec_fence (basic-wait) [91.385725] Starting subtest: basic-wait [91.387656] Starting dynamic subtest: rcs0 [91.415466] Dynamic subtest rcs0: SUCCESS (0.031s) [91.426443] Starting dynamic subtest: bcs0 [91.438547] Dynamic subtest bcs0: SUCCESS (0.023s) [91.448602] Starting dynamic subtest: vcs0 [91.459432] Dynamic subtest vcs0: SUCCESS (0.020s) [91.469266] Starting dynamic subtest: vcs1 [91.488504] Dynamic subtest vcs1: SUCCESS (0.029s) [91.499098] Starting dynamic subtest: vecs0 [91.514425] Dynamic subtest vecs0: SUCCESS (0.025s) [91.515519] Subtest basic-wait: SUCCESS (0.130s) [92.171473] [023/162] (948s left) gem_exec_fence (basic-await) [92.403565] Starting subtest: basic-await [92.404891] Starting dynamic subtest: rcs0 [92.515943] Dynamic subtest rcs0: SUCCESS (0.109s) [92.529045] Starting dynamic subtest: bcs0 [92.621960] Dynamic subtest bcs0: SUCCESS (0.108s) [92.635014] Starting dynamic subtest: vcs0 [92.738743] Dynamic subtest vcs0: SUCCESS (0.117s) [92.749141] Starting dynamic subtest: vcs1 [92.841704] Dynamic subtest vcs1: SUCCESS (0.104s) [92.856079] Starting dynamic subtest: vecs0 [92.954726] Dynamic subtest vecs0: SUCCESS (0.112s) [92.956141] Subtest basic-await: SUCCESS (0.553s) [93.672167] [024/162] (946s left) gem_exec_fence (nb-await) [93.892427] Starting subtest: nb-await [93.895290] Starting dynamic subtest: rcs0 [93.971110] Dynamic subtest rcs0: SUCCESS (0.079s) [93.988596] Starting dynamic subtest: bcs0 [94.047573] Dynamic subtest bcs0: SUCCESS (0.073s) [94.078516] Starting dynamic subtest: vcs0 [94.136503] Dynamic subtest vcs0: SUCCESS (0.087s) [94.175609] Starting dynamic subtest: vcs1 [94.232135] Dynamic subtest vcs1: SUCCESS (0.096s) [94.264529] Starting dynamic subtest: vecs0 [94.317350] Dynamic subtest vecs0: SUCCESS (0.085s) [94.319386] Subtest nb-await: SUCCESS (0.427s) [95.057278] [025/162] (945s left) gem_exec_gttfill (basic) [95.141775] Starting subtest: basic [100.189957] Subtest basic: SUCCESS (5.048s) [100.441812] [026/162] (940s left) gem_exec_parallel (engines) [100.666641] Starting subtest: engines [100.667752] Starting dynamic subtest: basic [102.965230] Dynamic subtest basic: SUCCESS (2.320s) [102.979539] Starting dynamic subtest: contexts [105.792616] Dynamic subtest contexts: SUCCESS (2.816s) [105.810048] Starting dynamic subtest: fds [114.552985] Dynamic subtest fds: SUCCESS (8.794s) [114.564242] Starting dynamic subtest: userptr [116.940511] Dynamic subtest userptr: SUCCESS (2.364s) [116.942566] Subtest engines: SUCCESS (16.296s) [117.113035] [027/162] (923s left) gem_exec_store (basic) [117.196565] Starting subtest: basic [117.242619] Subtest basic: SUCCESS (0.046s) [117.446853] [028/162] (923s left) gem_flink_basic (bad-flink) [117.506501] Starting subtest: bad-flink [117.507593] Subtest bad-flink: SUCCESS (0.000s) [117.560641] [029/162] (923s left) gem_flink_basic (bad-open) [117.617397] Starting subtest: bad-open [117.618496] Subtest bad-open: SUCCESS (0.000s) [117.671600] [030/162] (923s left) gem_flink_basic (basic) [117.992193] Starting subtest: basic [117.994881] Subtest basic: SUCCESS (0.000s) [118.092888] [031/162] (922s left) gem_flink_basic (double-flink) [118.148933] Starting subtest: double-flink [118.149887] Subtest double-flink: SUCCESS (0.000s) [118.220866] [032/162] (922s left) gem_flink_basic (flink-lifetime) [118.275980] Starting subtest: flink-lifetime [118.279108] Subtest flink-lifetime: SUCCESS (0.002s) [118.350868] [033/162] (922s left) gem_huc_copy (huc-copy) [118.424055] Starting subtest: huc-copy [118.426792] Subtest huc-copy: SKIP (0.000s) [118.518566] [034/162] (922s left) gem_linear_blits (basic) [118.694167] Starting subtest: basic [118.706692] Subtest basic: SUCCESS (0.013s) [118.804617] [035/162] (922s left) gem_mmap (basic) [118.960179] Starting subtest: basic [118.965247] Subtest basic: SUCCESS (0.001s) [119.048346] [036/162] (922s left) gem_mmap_gtt (basic) [119.108162] Starting subtest: basic [119.109125] Subtest basic: SUCCESS (0.001s) [119.162154] [037/162] (922s left) gem_render_linear_blits (basic) [119.229240] Starting subtest: basic [119.259970] Subtest basic: SUCCESS (0.032s) [119.330905] [038/162] (921s left) gem_render_tiled_blits (basic) [119.396852] Starting subtest: basic [119.438508] Subtest basic: SUCCESS (0.042s) [119.506253] [039/162] (921s left) gem_ringfill (basic-all) [119.793971] Starting subtest: basic-all [121.014509] Subtest basic-all: SUCCESS (1.164s) [121.076927] [040/162] (920s left) gem_softpin (allocator-basic) [121.148082] Starting subtest: allocator-basic [121.357900] Subtest allocator-basic: SUCCESS (0.155s) [121.408987] [041/162] (920s left) gem_softpin (allocator-basic-reserve) [121.480477] Starting subtest: allocator-basic-reserve [121.680504] Subtest allocator-basic-reserve: SUCCESS (0.144s) [121.731777] [042/162] (919s left) gem_softpin (safe-alignment) [121.807664] Starting subtest: safe-alignment [121.825620] Subtest safe-alignment: SUCCESS (0.018s) [121.927238] [043/162] (919s left) gem_sync (basic-all) [122.010289] Starting subtest: basic-all [124.686215] Subtest basic-all: SUCCESS (2.627s) [124.822641] [044/162] (916s left) gem_sync (basic-each) [124.903487] Starting subtest: basic-each [127.115861] Subtest basic-each: SUCCESS (2.213s) [127.287612] [045/162] (914s left) gem_tiled_blits (basic) [127.426385] Starting subtest: basic [127.448513] Subtest basic: SUCCESS (0.022s) [127.567617] [046/162] (914s left) gem_tiled_fence_blits (basic) [128.136574] Starting subtest: basic [128.146340] Subtest basic: SUCCESS (0.010s) [128.249609] [047/162] (913s left) gem_tiled_pread_basic (basic) [128.357239] Starting subtest: basic [128.562566] Subtest basic: SUCCESS (0.149s) [128.622770] [048/162] (913s left) gem_wait (busy@all-engines) [128.709716] Starting subtest: busy [128.711558] Starting dynamic subtest: all-engines [129.289040] Dynamic subtest all-engines: SUCCESS (0.577s) [129.291205] Subtest busy: SUCCESS (0.577s) [129.515237] [049/162] (912s left) gem_wait (wait@all-engines) [129.599967] Starting subtest: wait [129.601335] Starting dynamic subtest: all-engines [130.686986] Dynamic subtest all-engines: SUCCESS (1.036s) [130.689426] Subtest wait: SUCCESS (1.037s) [130.876088] [050/162] (911s left) i915_getparams_basic (basic-eu-total) [130.940854] Starting subtest: basic-eu-total [130.943132] Subtest basic-eu-total: SUCCESS (0.000s) [130.996655] [051/162] (911s left) i915_getparams_basic (basic-subslice-total) [131.057685] Starting subtest: basic-subslice-total [131.061352] Subtest basic-subslice-total: SUCCESS (0.000s) [131.110990] [052/162] (911s left) i915_hangman (error-state-basic) [131.199687] Starting subtest: error-state-basic [131.208795] Subtest error-state-basic: SUCCESS (0.009s) [131.433634] [053/162] (910s left) i915_pciid [131.661874] [054/162] (910s left) intel_hwmon (hwmon-read) [131.811678] Subtest hwmon-read: SKIP (0.000s) [131.869643] [055/162] (910s left) intel_hwmon (hwmon-write) [131.926216] Subtest hwmon-write: SKIP (0.000s) [131.980175] [056/162] (910s left) kms_addfb_basic (addfb25-4-tiled) [132.260285] Starting subtest: addfb25-4-tiled [132.261904] Subtest addfb25-4-tiled: SUCCESS (0.001s) [132.351944] [057/162] (910s left) kms_addfb_basic (addfb25-bad-modifier) [132.614640] Starting subtest: addfb25-bad-modifier [132.615761] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [132.702337] [058/162] (909s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [132.975508] Starting subtest: addfb25-framebuffer-vs-set-tiling [132.978101] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [133.067157] [059/162] (909s left) kms_addfb_basic (addfb25-modifier-no-flag) [133.341741] Starting subtest: addfb25-modifier-no-flag [133.342960] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [133.420579] [060/162] (909s left) kms_addfb_basic (addfb25-x-tiled-legacy) [133.698660] Starting subtest: addfb25-x-tiled-legacy [133.699919] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [133.771836] [061/162] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [134.044783] Starting subtest: addfb25-x-tiled-mismatch-legacy [134.046093] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [134.133153] [062/162] (908s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [134.401140] Starting subtest: addfb25-yf-tiled-legacy [134.402201] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [134.488819] [063/162] (908s left) kms_addfb_basic (addfb25-y-tiled-legacy) [134.768931] Starting subtest: addfb25-y-tiled-legacy [134.770253] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [134.869467] [064/162] (908s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [135.145617] Starting subtest: addfb25-y-tiled-small-legacy [135.147035] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [135.247625] [065/162] (907s left) kms_addfb_basic (bad-pitch-0) [135.305240] Starting subtest: bad-pitch-0 [135.306182] Subtest bad-pitch-0: SUCCESS (0.000s) [135.602943] [066/162] (907s left) kms_addfb_basic (bad-pitch-1024) [135.659806] Starting subtest: bad-pitch-1024 [135.660924] Subtest bad-pitch-1024: SUCCESS (0.000s) [135.956444] [067/162] (907s left) kms_addfb_basic (bad-pitch-128) [136.014492] Starting subtest: bad-pitch-128 [136.015409] Subtest bad-pitch-128: SUCCESS (0.000s) [136.309088] [068/162] (906s left) kms_addfb_basic (bad-pitch-256) [136.367144] Starting subtest: bad-pitch-256 [136.368156] Subtest bad-pitch-256: SUCCESS (0.000s) [136.668348] [069/162] (906s left) kms_addfb_basic (bad-pitch-32) [136.725212] Starting subtest: bad-pitch-32 [136.726146] Subtest bad-pitch-32: SUCCESS (0.000s) [137.037105] [070/162] (906s left) kms_addfb_basic (bad-pitch-63) [137.094651] Starting subtest: bad-pitch-63 [137.095766] Subtest bad-pitch-63: SUCCESS (0.000s) [137.383459] [071/162] (906s left) kms_addfb_basic (bad-pitch-65536) [137.440892] Starting subtest: bad-pitch-65536 [137.441961] Subtest bad-pitch-65536: SUCCESS (0.000s) [137.727658] [072/162] (905s left) kms_addfb_basic (bad-pitch-999) [137.788309] Starting subtest: bad-pitch-999 [137.789938] Subtest bad-pitch-999: SUCCESS (0.000s) [138.084032] [073/162] (905s left) kms_addfb_basic (basic) [138.140384] Starting subtest: basic [138.141330] Subtest basic: SUCCESS (0.000s) [138.448926] [074/162] (905s left) kms_addfb_basic (basic-x-tiled-legacy) [138.507085] Starting subtest: basic-x-tiled-legacy [138.507973] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [138.803264] [075/162] (904s left) kms_addfb_basic (basic-y-tiled-legacy) [138.862236] Starting subtest: basic-y-tiled-legacy [138.863083] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [139.171023] [076/162] (904s left) kms_addfb_basic (bo-too-small) [139.442527] Starting subtest: bo-too-small [139.443868] Subtest bo-too-small: SUCCESS (0.000s) [139.518448] [077/162] (904s left) kms_addfb_basic (bo-too-small-due-to-tiling) [139.785431] Starting subtest: bo-too-small-due-to-tiling [139.786513] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [139.865738] [078/162] (904s left) kms_addfb_basic (clobberred-modifier) [139.924061] Starting subtest: clobberred-modifier [139.924982] Subtest clobberred-modifier: SUCCESS (0.000s) [140.234546] [079/162] (903s left) kms_addfb_basic (framebuffer-vs-set-tiling) [140.293473] Starting subtest: framebuffer-vs-set-tiling [140.294464] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [140.600600] [080/162] (903s left) kms_addfb_basic (invalid-get-prop) [140.660123] Starting subtest: invalid-get-prop [140.661301] Subtest invalid-get-prop: SUCCESS (0.000s) [140.965108] [081/162] (903s left) kms_addfb_basic (invalid-get-prop-any) [141.022415] Starting subtest: invalid-get-prop-any [141.023482] Subtest invalid-get-prop-any: SUCCESS (0.000s) [141.311336] [082/162] (902s left) kms_addfb_basic (invalid-set-prop) [141.367589] Starting subtest: invalid-set-prop [141.368528] Subtest invalid-set-prop: SUCCESS (0.000s) [141.657443] [083/162] (902s left) kms_addfb_basic (invalid-set-prop-any) [141.713798] Starting subtest: invalid-set-prop-any [141.714944] Subtest invalid-set-prop-any: SUCCESS (0.000s) [142.006138] [084/162] (902s left) kms_addfb_basic (no-handle) [142.063590] Starting subtest: no-handle [142.065084] Subtest no-handle: SUCCESS (0.000s) [142.366955] [085/162] (902s left) kms_addfb_basic (size-max) [142.638774] Starting subtest: size-max [142.640980] Subtest size-max: SUCCESS (0.000s) [142.722974] [086/162] (901s left) kms_addfb_basic (small-bo) [143.013597] Starting subtest: small-bo [143.015072] Subtest small-bo: SUCCESS (0.000s) [143.124720] [087/162] (901s left) kms_addfb_basic (tile-pitch-mismatch) [143.183219] Starting subtest: tile-pitch-mismatch [143.184173] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [143.494403] [088/162] (901s left) kms_addfb_basic (too-high) [143.779799] Starting subtest: too-high [143.784120] Subtest too-high: SUCCESS (0.002s) [143.866842] [089/162] (900s left) kms_addfb_basic (too-wide) [144.137687] Starting subtest: too-wide [144.138871] Subtest too-wide: SUCCESS (0.000s) [144.207992] [090/162] (900s left) kms_addfb_basic (unused-handle) [144.265482] Starting subtest: unused-handle [144.266615] Subtest unused-handle: SUCCESS (0.000s) [144.580886] [091/162] (900s left) kms_addfb_basic (unused-modifier) [144.638277] Starting subtest: unused-modifier [144.639150] Subtest unused-modifier: SUCCESS (0.000s) [144.966414] [092/162] (899s left) kms_addfb_basic (unused-offsets) [145.023536] Starting subtest: unused-offsets [145.025127] Subtest unused-offsets: SUCCESS (0.000s) [145.313285] [093/162] (899s left) kms_addfb_basic (unused-pitches) [145.368641] Starting subtest: unused-pitches [145.369661] Subtest unused-pitches: SUCCESS (0.000s) [145.666288] [094/162] (899s left) kms_busy (basic) [145.944994] Subtest basic: SKIP (0.000s) [146.008266] [095/162] (899s left) kms_prop_blob (basic) [146.069111] Starting subtest: basic [146.070128] Subtest basic: SUCCESS (0.000s) [146.125903] [096/162] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [146.407256] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [146.467479] [097/162] (898s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [146.742095] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [146.797488] [098/162] (898s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [147.074900] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [147.140063] [099/162] (898s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [147.422483] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [147.483205] [100/162] (897s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [147.758885] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [147.813364] [101/162] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [148.084752] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [148.147769] [102/162] (897s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [148.428505] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [148.505042] [103/162] (897s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [148.839689] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [148.891494] [104/162] (896s left) kms_dsc (dsc-basic) [149.164701] Subtest dsc-basic: SKIP (0.000s) [149.228154] [105/162] (896s left) kms_flip (basic-flip-vs-dpms) [149.503195] Starting subtest: basic-flip-vs-dpms [149.507405] Subtest basic-flip-vs-dpms: SKIP (0.003s) [149.586202] [106/162] (896s left) kms_flip (basic-flip-vs-modeset) [149.861092] Starting subtest: basic-flip-vs-modeset [149.867164] Subtest basic-flip-vs-modeset: SKIP (0.003s) [149.946285] [107/162] (895s left) kms_flip (basic-flip-vs-wf_vblank) [150.219200] Starting subtest: basic-flip-vs-wf_vblank [150.223255] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [150.298886] [108/162] (895s left) kms_flip (basic-plain-flip) [150.572374] Starting subtest: basic-plain-flip [150.578269] Subtest basic-plain-flip: SKIP (0.003s) [150.655080] [109/162] (895s left) kms_force_connector_basic (force-connector-state) [151.046689] Starting subtest: force-connector-state [151.846173] Subtest force-connector-state: SUCCESS (0.801s) [152.439450] [110/162] (893s left) kms_force_connector_basic (force-edid) [152.829585] Starting subtest: force-edid [153.474137] Subtest force-edid: SUCCESS (0.645s) [153.985555] [111/162] (892s left) kms_force_connector_basic (force-load-detect) [154.373600] Starting subtest: force-load-detect [154.375687] Subtest force-load-detect: SKIP (0.000s) [154.760645] [112/162] (891s left) kms_force_connector_basic (prune-stale-modes) [155.151240] Starting subtest: prune-stale-modes [155.884992] Subtest prune-stale-modes: SUCCESS (0.734s) [156.405730] [113/162] (889s left) kms_frontbuffer_tracking (basic) [156.673176] Subtest basic: SKIP (0.000s) [156.756846] [114/162] (889s left) kms_hdmi_inject (inject-audio) [156.818057] Starting subtest: inject-audio [157.441530] Subtest inject-audio: SUCCESS (0.621s) [157.732852] [115/162] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [157.997299] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [158.077429] [116/162] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [158.359819] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [158.425416] [117/162] (888s left) kms_pipe_crc_basic (hang-read-crc) [158.701720] Subtest hang-read-crc: SKIP (0.000s) [158.778062] [118/162] (887s left) kms_pipe_crc_basic (nonblocking-crc) [159.042360] Subtest nonblocking-crc: SKIP (0.000s) [159.117157] [119/162] (887s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [159.379730] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [159.447983] [120/162] (887s left) kms_pipe_crc_basic (read-crc) [159.721353] Subtest read-crc: SKIP (0.000s) [159.790341] [121/162] (886s left) kms_pipe_crc_basic (read-crc-frame-sequence) [160.058136] Subtest read-crc-frame-sequence: SKIP (0.000s) [160.133460] [122/162] (886s left) kms_pm_backlight (basic-brightness) [160.403405] Subtest basic-brightness: SKIP (0.000s) [160.479242] [123/162] (886s left) kms_pm_rpm (basic-pci-d3-state) [162.110258] Starting subtest: basic-pci-d3-state [162.484276] Subtest basic-pci-d3-state: SUCCESS (0.340s) [162.642372] [124/162] (884s left) kms_pm_rpm (basic-rte) [162.699500] Starting subtest: basic-rte [164.581594] Subtest basic-rte: SUCCESS (1.878s) [165.109243] [125/162] (881s left) kms_psr (psr-primary-page-flip) [165.515213] Subtest psr-primary-page-flip: SKIP (0.000s) [165.590633] [126/162] (881s left) kms_psr (psr-cursor-plane-move) [165.867103] Subtest psr-cursor-plane-move: SKIP (0.000s) [165.933498] [127/162] (881s left) kms_psr (psr-sprite-plane-onoff) [166.209394] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [166.280429] [128/162] (880s left) kms_psr (psr-primary-mmap-gtt) [166.550895] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [166.624416] [129/162] (880s left) kms_setmode (basic-clone-single-crtc) [166.684602] Starting subtest: basic-clone-single-crtc [166.687905] Subtest basic-clone-single-crtc: SKIP (0.000s) [166.750247] [130/162] (880s left) i915_pm_rps (basic-api) [166.820578] Starting subtest: basic-api [166.825164] Subtest basic-api: SUCCESS (0.005s) [166.887237] [131/162] (880s left) prime_self_import (basic-llseek-bad) [166.944618] Starting subtest: basic-llseek-bad [166.948907] Subtest basic-llseek-bad: SUCCESS (0.003s) [167.026898] [132/162] (880s left) prime_self_import (basic-llseek-size) [167.083717] Starting subtest: basic-llseek-size [167.087287] Subtest basic-llseek-size: SUCCESS (0.005s) [167.170281] [133/162] (880s left) prime_self_import (basic-with_fd_dup) [167.224218] Starting subtest: basic-with_fd_dup [167.229131] Subtest basic-with_fd_dup: SUCCESS (0.005s) [167.310013] [134/162] (880s left) prime_self_import (basic-with_one_bo) [167.363504] Starting subtest: basic-with_one_bo [167.368241] Subtest basic-with_one_bo: SUCCESS (0.004s) [167.430674] [135/162] (880s left) prime_self_import (basic-with_one_bo_two_files) [167.486212] Starting subtest: basic-with_one_bo_two_files [167.490630] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [167.573027] [136/162] (880s left) prime_self_import (basic-with_two_bos) [167.628719] Starting subtest: basic-with_two_bos [167.632071] Subtest basic-with_two_bos: SUCCESS (0.004s) [167.708932] [137/162] (880s left) prime_vgem (basic-fence-flip) [167.780527] Starting subtest: basic-fence-flip [167.997430] Subtest basic-fence-flip: SKIP (0.215s) [168.074635] [138/162] (879s left) prime_vgem (basic-fence-mmap) [168.142024] Starting subtest: basic-fence-mmap [168.177096] Subtest basic-fence-mmap: SUCCESS (0.035s) [168.242641] [139/162] (879s left) prime_vgem (basic-fence-read) [168.308407] Starting subtest: basic-fence-read [168.383979] Subtest basic-fence-read: SUCCESS (0.075s) [168.454508] [140/162] (879s left) prime_vgem (basic-gtt) [168.521844] Starting subtest: basic-gtt [168.540441] Subtest basic-gtt: SUCCESS (0.019s) [168.632605] [141/162] (879s left) prime_vgem (basic-read) [168.699474] Starting subtest: basic-read [168.736542] Subtest basic-read: SUCCESS (0.036s) [168.818027] [142/162] (879s left) prime_vgem (basic-write) [168.885604] Starting subtest: basic-write [168.921708] Subtest basic-write: SUCCESS (0.036s) [168.989639] [143/162] (879s left) vgem_basic (setversion) [169.048821] Starting subtest: setversion [169.051271] Subtest setversion: SUCCESS (0.000s) [169.108463] [144/162] (879s left) vgem_basic (create) [169.168148] Starting subtest: create [169.169201] Subtest create: SUCCESS (0.000s) [169.226548] [145/162] (878s left) vgem_basic (debugfs) [169.285195] Starting subtest: debugfs [169.286177] Subtest debugfs: SUCCESS (0.000s) [169.343760] [146/162] (878s left) vgem_basic (dmabuf-export) [169.403212] Starting subtest: dmabuf-export [169.415474] Subtest dmabuf-export: SUCCESS (0.012s) [169.495169] [147/162] (878s left) vgem_basic (dmabuf-fence) [169.556348] Starting subtest: dmabuf-fence [169.557269] Subtest dmabuf-fence: SUCCESS (0.002s) [169.617019] [148/162] (878s left) vgem_basic (dmabuf-fence-before) [169.674938] Starting subtest: dmabuf-fence-before [169.675897] Subtest dmabuf-fence-before: SUCCESS (0.000s) [169.733840] [149/162] (878s left) vgem_basic (dmabuf-mmap) [169.793233] Starting subtest: dmabuf-mmap [169.804659] Subtest dmabuf-mmap: SUCCESS (0.012s) [169.864715] [150/162] (878s left) vgem_basic (mmap) [169.924045] Starting subtest: mmap [169.932304] Subtest mmap: SUCCESS (0.009s) [169.993166] [151/162] (878s left) vgem_basic (second-client) [170.052918] Starting subtest: second-client [170.058022] Subtest second-client: SUCCESS (0.005s) [170.120174] [152/162] (878s left) vgem_basic (sysfs) [170.179555] Starting subtest: sysfs [170.180980] Subtest sysfs: SUCCESS (0.001s) [170.239431] [153/162] (878s left) core_hotunplug (unbind-rebind) [170.348118] Starting subtest: unbind-rebind [174.473872] Subtest unbind-rebind: SUCCESS (4.120s) [174.528055] [154/162] (874s left) vgem_basic (unload) [174.591540] Starting subtest: unload [203.580970] Subtest unload: SUCCESS (28.933s) [203.635340] [155/162] (845s left) i915_module_load (reload) [203.697028] Starting subtest: reload [206.938743] Subtest reload: SUCCESS (3.242s) [207.052194] [156/162] (841s left) gem_lmem_swapping (basic) [207.177411] Subtest basic: SKIP (0.000s) [207.246681] [157/162] (841s left) gem_lmem_swapping (parallel-random-engines) [207.310206] Subtest parallel-random-engines: SKIP (0.000s) [207.363783] [158/162] (841s left) gem_lmem_swapping (random-engines) [207.426541] Subtest random-engines: SKIP (0.000s) [207.481685] [159/162] (841s left) gem_lmem_swapping (verify-random) [207.546730] Subtest verify-random: SKIP (0.000s) [207.602264] [160/162] (841s left) i915_pm_rpm (module-reload) [210.692708] Starting subtest: module-reload [225.030500] Subtest module-reload: SUCCESS (14.284s) [225.094938] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [225.096669] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [225.099680] [161/162] (824s left) i915_selftest (live) [225.172283] Starting subtest: live [225.173577] Starting dynamic subtest: sanitycheck [227.728643] Dynamic subtest sanitycheck: SUCCESS (2.501s) [227.739140] Starting dynamic subtest: uncore [230.180351] Dynamic subtest uncore: SUCCESS (2.451s) [230.190886] Starting dynamic subtest: workarounds [233.151772] Dynamic subtest workarounds: SUCCESS (2.970s) [233.165496] Starting dynamic subtest: gt_engines [236.142510] Dynamic subtest gt_engines: SUCCESS (2.990s) [236.153054] Starting dynamic subtest: gt_timelines [250.293992] Dynamic subtest gt_timelines: SUCCESS (14.150s) [250.304619] Starting dynamic subtest: gt_contexts [252.979490] Dynamic subtest gt_contexts: SUCCESS (2.685s) [252.990055] Starting dynamic subtest: gt_lrc [258.527554] Dynamic subtest gt_lrc: SUCCESS (5.547s) [258.541326] Starting dynamic subtest: gt_mocs [261.056656] Dynamic subtest gt_mocs: SUCCESS (2.528s) [261.067182] Starting dynamic subtest: gt_pm [272.145945] Dynamic subtest gt_pm: SUCCESS (11.088s) [272.159766] Starting dynamic subtest: gt_heartbeat [274.616812] Dynamic subtest gt_heartbeat: SUCCESS (2.470s) [274.627350] Starting dynamic subtest: gt_tlb [278.741721] Dynamic subtest gt_tlb: SUCCESS (4.124s) [278.752286] Starting dynamic subtest: requests [288.732804] Dynamic subtest requests: SUCCESS (9.990s) [288.743608] Starting dynamic subtest: migrate [294.164519] Dynamic subtest migrate: SUCCESS (5.431s) [294.178276] Starting dynamic subtest: active [296.641061] Dynamic subtest active: SUCCESS (2.476s) [296.651651] Starting dynamic subtest: objects [300.043624] Dynamic subtest objects: SUCCESS (3.401s) [300.057445] Starting dynamic subtest: mman [306.091123] Dynamic subtest mman: SUCCESS (6.046s) [306.101783] Starting dynamic subtest: dmabuf [308.585586] Dynamic subtest dmabuf: SUCCESS (2.547s) [308.598406] Starting dynamic subtest: vma [311.094524] Dynamic subtest vma: SUCCESS (2.453s) [311.108378] Starting dynamic subtest: coherency [314.731649] Dynamic subtest coherency: SUCCESS (3.635s) [314.745492] Starting dynamic subtest: gtt [324.428095] Dynamic subtest gtt: SUCCESS (9.694s) [324.438768] Starting dynamic subtest: gem [327.421641] Dynamic subtest gem: SUCCESS (2.992s) [327.432279] Starting dynamic subtest: evict [332.197859] Dynamic subtest evict: SUCCESS (4.774s) [332.211701] Starting dynamic subtest: hugepages [341.106632] Dynamic subtest hugepages: SUCCESS (8.907s) [341.117316] Starting dynamic subtest: gem_contexts [360.753118] Dynamic subtest gem_contexts: SUCCESS (19.644s) [360.763850] Starting dynamic subtest: client [363.322649] Dynamic subtest client: SUCCESS (2.568s) [363.333336] Starting dynamic subtest: gem_migrate [365.761216] Dynamic subtest gem_migrate: SUCCESS (2.436s) [365.773986] Starting dynamic subtest: reset [368.683436] Dynamic subtest reset: SUCCESS (2.921s) [368.694105] Starting dynamic subtest: memory_region [371.161716] Dynamic subtest memory_region: SUCCESS (2.476s) [371.172429] Starting dynamic subtest: hangcheck [402.302156] Dynamic subtest hangcheck: SUCCESS (31.138s) [402.316078] Starting dynamic subtest: execlists [417.634862] Dynamic subtest execlists: SUCCESS (15.330s) [417.648781] Starting dynamic subtest: ring_submission [420.100332] Dynamic subtest ring_submission: SUCCESS (2.464s) [420.111231] Starting dynamic subtest: perf [422.625019] Dynamic subtest perf: SUCCESS (2.522s) [422.635747] Starting dynamic subtest: slpc [425.082586] Dynamic subtest slpc: SUCCESS (2.456s) [425.093324] Starting dynamic subtest: guc [427.552529] Dynamic subtest guc: SUCCESS (2.468s) [427.563222] Starting dynamic subtest: guc_multi_lrc [430.011656] Dynamic subtest guc_multi_lrc: SUCCESS (2.457s) [430.025635] Starting dynamic subtest: guc_hang [432.468254] Dynamic subtest guc_hang: SUCCESS (2.455s) [432.478988] Starting dynamic subtest: late_gt_pm [434.955031] Dynamic subtest late_gt_pm: SUCCESS (2.484s) [434.957186] Subtest live: SUCCESS (209.725s) [435.026592] [162/162] (614s left) dmabuf (all-tests) [435.097095] Starting subtest: all-tests [435.098578] Starting dynamic subtest: sanitycheck [435.166157] Dynamic subtest sanitycheck: SUCCESS (0.068s) [435.200354] Starting dynamic subtest: dma_fence [435.348701] Dynamic subtest dma_fence: SUCCESS (0.179s) [435.365752] Starting dynamic subtest: dma_fence_chain [435.369407] Dynamic subtest dma_fence_chain: SKIP (0.000s) [435.380468] Starting dynamic subtest: dma_fence_unwrap [435.416718] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s) [435.442646] Starting dynamic subtest: dma_resv [435.486490] Dynamic subtest dma_resv: SUCCESS (0.066s) [435.489594] Subtest all-tests: SUCCESS (0.392s) [435.578255] 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.