[58.185867] Initializing watchdogs [58.185994] /dev/watchdog0 [58.211583] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [58.220295] [001/162] (960s left) i915_module_load (load) [58.307783] Starting subtest: load [60.697301] Subtest load: SUCCESS (2.416s) [60.749222] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [60.751701] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [60.759318] [002/162] (958s left) core_auth (basic-auth) [60.905240] Starting subtest: basic-auth [60.909708] Subtest basic-auth: SUCCESS (0.003s) [60.981348] [003/162] (957s left) core_debugfs (read-all-entries) [61.055706] Starting subtest: read-all-entries [61.059304] Subtest read-all-entries: SUCCESS (0.005s) [61.110884] [004/162] (957s left) core_sysfs (read-all-entries) [61.182513] Starting subtest: read-all-entries [61.186165] Subtest read-all-entries: SUCCESS (0.005s) [61.241207] [005/162] (957s left) fbdev (eof) [61.317775] Subtest eof: SKIP (0.000s) [61.369280] [006/162] (957s left) fbdev (info) [61.444816] Subtest info: SKIP (0.000s) [61.495263] [007/162] (957s left) fbdev (nullptr) [61.569530] Subtest nullptr: SKIP (0.000s) [61.620347] [008/162] (957s left) fbdev (read) [61.695682] Subtest read: SKIP (0.000s) [61.745472] [009/162] (957s left) fbdev (write) [61.824074] Subtest write: SKIP (0.000s) [61.874217] [010/162] (957s left) gem_basic (bad-close) [61.942135] Starting subtest: bad-close [61.948963] Subtest bad-close: SUCCESS (0.000s) [61.998464] [011/162] (957s left) gem_basic (create-close) [62.062780] Starting subtest: create-close [62.069216] Subtest create-close: SUCCESS (0.000s) [62.128319] [012/162] (957s left) gem_basic (create-fd-close) [62.195866] Starting subtest: create-fd-close [62.202277] Subtest create-fd-close: SUCCESS (0.000s) [62.267940] [013/162] (957s left) gem_busy (busy@all-engines) [62.359088] Starting subtest: busy [62.362620] Starting dynamic subtest: all-engines [62.415236] Dynamic subtest all-engines: SUCCESS (0.059s) [62.418719] Subtest busy: SUCCESS (0.060s) [62.828058] [014/162] (956s left) gem_close_race (basic-process) [62.926574] Starting subtest: basic-process [62.993159] Subtest basic-process: SUCCESS (0.071s) [63.188331] [015/162] (956s left) gem_close_race (basic-threads) [63.285415] Starting subtest: basic-threads [64.427789] Subtest basic-threads: SUCCESS (1.154s) [64.644091] [016/162] (955s left) gem_ctx_create (basic) [64.737832] Starting subtest: basic [64.743111] Subtest basic: SUCCESS (0.000s) [64.921647] [017/162] (954s left) gem_ctx_create (basic-files) [65.211569] Starting subtest: basic-files [67.262085] Subtest basic-files: SUCCESS (2.063s) [67.981728] [018/162] (951s left) gem_ctx_exec (basic) [68.080607] Starting subtest: basic [68.089811] Subtest basic: SUCCESS (0.010s) [68.252723] [019/162] (951s left) gem_exec_basic (basic) [68.342123] Starting subtest: basic [68.343724] Starting dynamic subtest: rcs0-smem [68.344871] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [68.358381] Starting dynamic subtest: bcs0-smem [68.359564] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [68.370573] Starting dynamic subtest: vcs0-smem [68.371771] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [68.382359] Starting dynamic subtest: vcs1-smem [68.383556] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [68.393982] Starting dynamic subtest: vecs0-smem [68.395229] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [68.396371] Subtest basic: SUCCESS (0.010s) [68.554193] [020/162] (951s left) gem_exec_create (basic) [68.633469] Starting subtest: basic [68.635338] Starting dynamic subtest: smem [70.719691] Dynamic subtest smem: SUCCESS (2.054s) [70.721594] Subtest basic: SUCCESS (2.054s) [70.863374] [021/162] (949s left) gem_exec_fence (basic-busy) [71.086105] Starting subtest: basic-busy [71.087923] Starting dynamic subtest: rcs0 [71.117467] Dynamic subtest rcs0: SUCCESS (0.033s) [71.134754] Starting dynamic subtest: bcs0 [71.156578] Dynamic subtest bcs0: SUCCESS (0.039s) [71.172064] Starting dynamic subtest: vcs0 [71.180585] Dynamic subtest vcs0: SUCCESS (0.024s) [71.196257] Starting dynamic subtest: vcs1 [71.201373] Dynamic subtest vcs1: SUCCESS (0.020s) [71.217380] Starting dynamic subtest: vecs0 [71.224779] Dynamic subtest vecs0: SUCCESS (0.022s) [71.226935] Subtest basic-busy: SUCCESS (0.140s) [71.924401] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [71.927166] [022/162] (948s left) gem_exec_fence (basic-wait) [72.160137] Starting subtest: basic-wait [72.162117] Starting dynamic subtest: rcs0 [72.196554] Dynamic subtest rcs0: SUCCESS (0.039s) [72.212635] Starting dynamic subtest: bcs0 [72.220584] Dynamic subtest bcs0: SUCCESS (0.024s) [72.236426] Starting dynamic subtest: vcs0 [72.243269] Dynamic subtest vcs0: SUCCESS (0.022s) [72.256060] Starting dynamic subtest: vcs1 [72.264429] Dynamic subtest vcs1: SUCCESS (0.021s) [72.276122] Starting dynamic subtest: vecs0 [72.286454] Dynamic subtest vecs0: SUCCESS (0.022s) [72.287678] Subtest basic-wait: SUCCESS (0.130s) [72.929591] [023/162] (947s left) gem_exec_fence (basic-await) [73.140840] Starting subtest: basic-await [73.142625] Starting dynamic subtest: rcs0 [73.312922] Dynamic subtest rcs0: SUCCESS (0.114s) [73.325460] Starting dynamic subtest: bcs0 [73.359415] Dynamic subtest bcs0: SUCCESS (0.105s) [73.372012] Starting dynamic subtest: vcs0 [73.467360] Dynamic subtest vcs0: SUCCESS (0.107s) [73.483718] Starting dynamic subtest: vcs1 [73.571360] Dynamic subtest vcs1: SUCCESS (0.104s) [73.587498] Starting dynamic subtest: vecs0 [73.682191] Dynamic subtest vecs0: SUCCESS (0.111s) [73.683379] Subtest basic-await: SUCCESS (0.544s) [74.377769] [024/162] (945s left) gem_exec_fence (nb-await) [74.595919] Starting subtest: nb-await [74.597273] Starting dynamic subtest: rcs0 [74.667691] Dynamic subtest rcs0: SUCCESS (0.071s) [74.685437] Starting dynamic subtest: bcs0 [74.740505] Dynamic subtest bcs0: SUCCESS (0.071s) [74.776343] Starting dynamic subtest: vcs0 [74.830296] Dynamic subtest vcs0: SUCCESS (0.089s) [74.865876] Starting dynamic subtest: vcs1 [74.921939] Dynamic subtest vcs1: SUCCESS (0.091s) [74.958095] Starting dynamic subtest: vecs0 [75.009116] Dynamic subtest vecs0: SUCCESS (0.086s) [75.011672] Subtest nb-await: SUCCESS (0.414s) [75.732640] [025/162] (944s left) gem_exec_gttfill (basic) [75.815556] Starting subtest: basic [81.047177] Subtest basic: SUCCESS (5.237s) [81.305399] [026/162] (939s left) gem_exec_parallel (engines) [81.482234] Starting subtest: engines [81.483340] Starting dynamic subtest: basic [84.090051] Dynamic subtest basic: SUCCESS (2.562s) [84.102762] Starting dynamic subtest: contexts [86.768023] Dynamic subtest contexts: SUCCESS (2.664s) [86.784443] Starting dynamic subtest: fds [92.196310] Dynamic subtest fds: SUCCESS (5.459s) [92.214772] Starting dynamic subtest: userptr [94.622761] Dynamic subtest userptr: SUCCESS (2.407s) [94.624762] Subtest engines: SUCCESS (13.093s) [94.795720] [027/162] (925s left) gem_exec_store (basic) [94.879041] Starting subtest: basic [94.942070] Subtest basic: SUCCESS (0.063s) [95.150379] [028/162] (925s left) gem_flink_basic (bad-flink) [95.213717] Starting subtest: bad-flink [95.214857] Subtest bad-flink: SUCCESS (0.000s) [95.270349] [029/162] (925s left) gem_flink_basic (bad-open) [95.330848] Starting subtest: bad-open [95.332553] Subtest bad-open: SUCCESS (0.000s) [95.429591] [030/162] (925s left) gem_flink_basic (basic) [95.644584] Starting subtest: basic [95.646841] Subtest basic: SUCCESS (0.001s) [95.727154] [031/162] (925s left) gem_flink_basic (double-flink) [95.785759] Starting subtest: double-flink [95.786766] Subtest double-flink: SUCCESS (0.000s) [95.854021] [032/162] (925s left) gem_flink_basic (flink-lifetime) [95.913267] Starting subtest: flink-lifetime [95.915508] Subtest flink-lifetime: SUCCESS (0.002s) [95.988767] [033/162] (924s left) gem_huc_copy (huc-copy) [96.057918] Starting subtest: huc-copy [96.060291] Subtest huc-copy: SKIP (0.000s) [96.147353] [034/162] (924s left) gem_linear_blits (basic) [96.329602] Starting subtest: basic [96.383344] Subtest basic: SUCCESS (0.010s) [96.458991] [035/162] (924s left) gem_mmap (basic) [96.634797] Starting subtest: basic [96.640282] Subtest basic: SUCCESS (0.001s) [96.716293] [036/162] (924s left) gem_mmap_gtt (basic) [96.776282] Starting subtest: basic [96.778088] Subtest basic: SUCCESS (0.001s) [96.834765] [037/162] (924s left) gem_render_linear_blits (basic) [96.904356] Starting subtest: basic [96.940540] Subtest basic: SUCCESS (0.036s) [97.011132] [038/162] (924s left) gem_render_tiled_blits (basic) [97.078525] Starting subtest: basic [97.123560] Subtest basic: SUCCESS (0.045s) [97.194762] [039/162] (924s left) gem_ringfill (basic-all) [97.498229] Starting subtest: basic-all [98.721518] Subtest basic-all: SUCCESS (1.168s) [98.783645] [040/162] (922s left) gem_softpin (allocator-basic) [98.855868] Starting subtest: allocator-basic [99.057454] Subtest allocator-basic: SUCCESS (0.145s) [99.116794] [041/162] (922s left) gem_softpin (allocator-basic-reserve) [99.185682] Starting subtest: allocator-basic-reserve [99.399560] Subtest allocator-basic-reserve: SUCCESS (0.157s) [99.458717] [042/162] (922s left) gem_softpin (safe-alignment) [99.533642] Starting subtest: safe-alignment [99.551684] Subtest safe-alignment: SUCCESS (0.018s) [99.649828] [043/162] (921s left) gem_sync (basic-all) [99.729849] Starting subtest: basic-all [102.069287] Subtest basic-all: SUCCESS (2.298s) [102.240351] [044/162] (919s left) gem_sync (basic-each) [102.324744] Starting subtest: basic-each [104.598881] Subtest basic-each: SUCCESS (2.269s) [104.897450] [045/162] (916s left) gem_tiled_blits (basic) [105.054167] Starting subtest: basic [105.075560] Subtest basic: SUCCESS (0.020s) [105.199612] [046/162] (916s left) gem_tiled_fence_blits (basic) [105.792595] Starting subtest: basic [105.802841] Subtest basic: SUCCESS (0.011s) [105.896749] [047/162] (916s left) gem_tiled_pread_basic (basic) [106.025291] Starting subtest: basic [106.241536] Subtest basic: SUCCESS (0.160s) [106.311025] [048/162] (915s left) gem_wait (busy@all-engines) [106.401688] Starting subtest: busy [106.402780] Starting dynamic subtest: all-engines [106.984442] Dynamic subtest all-engines: SUCCESS (0.582s) [106.986619] Subtest busy: SUCCESS (0.583s) [107.277710] [049/162] (914s left) gem_wait (wait@all-engines) [107.361605] Starting subtest: wait [107.363127] Starting dynamic subtest: all-engines [108.457618] Dynamic subtest all-engines: SUCCESS (1.057s) [108.460279] Subtest wait: SUCCESS (1.058s) [108.667736] [050/162] (913s left) i915_getparams_basic (basic-eu-total) [108.730808] Starting subtest: basic-eu-total [108.734040] Subtest basic-eu-total: SUCCESS (0.000s) [108.788796] [051/162] (913s left) i915_getparams_basic (basic-subslice-total) [108.848596] Starting subtest: basic-subslice-total [108.850802] Subtest basic-subslice-total: SUCCESS (0.000s) [108.907882] [052/162] (913s left) i915_hangman (error-state-basic) [108.991077] Starting subtest: error-state-basic [109.000313] Subtest error-state-basic: SUCCESS (0.008s) [109.216118] [053/162] (913s left) i915_pciid [109.382814] [054/162] (913s left) intel_hwmon (hwmon-read) [109.441537] Subtest hwmon-read: SKIP (0.000s) [109.499065] [055/162] (913s left) intel_hwmon (hwmon-write) [109.561076] Subtest hwmon-write: SKIP (0.000s) [109.615571] [056/162] (913s left) kms_addfb_basic (addfb25-4-tiled) [109.927697] Starting subtest: addfb25-4-tiled [109.929480] Subtest addfb25-4-tiled: SUCCESS (0.001s) [110.019154] [057/162] (912s left) kms_addfb_basic (addfb25-bad-modifier) [110.336603] Starting subtest: addfb25-bad-modifier [110.338313] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [110.424691] [058/162] (912s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [110.722271] Starting subtest: addfb25-framebuffer-vs-set-tiling [110.724197] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [110.793242] [059/162] (912s left) kms_addfb_basic (addfb25-modifier-no-flag) [111.060648] Starting subtest: addfb25-modifier-no-flag [111.061850] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [111.145277] [060/162] (911s left) kms_addfb_basic (addfb25-x-tiled-legacy) [111.413377] Starting subtest: addfb25-x-tiled-legacy [111.414440] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [111.495788] [061/162] (911s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [111.769988] Starting subtest: addfb25-x-tiled-mismatch-legacy [111.771226] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [111.857442] [062/162] (911s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [112.133638] Starting subtest: addfb25-yf-tiled-legacy [112.135946] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [112.218817] [063/162] (910s left) kms_addfb_basic (addfb25-y-tiled-legacy) [112.492944] Starting subtest: addfb25-y-tiled-legacy [112.493988] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s) [112.579774] [064/162] (910s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [112.847198] Starting subtest: addfb25-y-tiled-small-legacy [112.848554] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [112.937848] [065/162] (910s left) kms_addfb_basic (bad-pitch-0) [112.997234] Starting subtest: bad-pitch-0 [112.998205] Subtest bad-pitch-0: SUCCESS (0.000s) [113.289803] [066/162] (910s left) kms_addfb_basic (bad-pitch-1024) [113.350301] Starting subtest: bad-pitch-1024 [113.351294] Subtest bad-pitch-1024: SUCCESS (0.000s) [113.671958] [067/162] (909s left) kms_addfb_basic (bad-pitch-128) [113.730997] Starting subtest: bad-pitch-128 [113.732051] Subtest bad-pitch-128: SUCCESS (0.000s) [114.042430] [068/162] (909s left) kms_addfb_basic (bad-pitch-256) [114.102635] Starting subtest: bad-pitch-256 [114.103681] Subtest bad-pitch-256: SUCCESS (0.000s) [114.396248] [069/162] (909s left) kms_addfb_basic (bad-pitch-32) [114.501485] Starting subtest: bad-pitch-32 [114.503060] Subtest bad-pitch-32: SUCCESS (0.000s) [114.807307] [070/162] (908s left) kms_addfb_basic (bad-pitch-63) [114.867309] Starting subtest: bad-pitch-63 [114.868334] Subtest bad-pitch-63: SUCCESS (0.000s) [115.159054] [071/162] (908s left) kms_addfb_basic (bad-pitch-65536) [115.222889] Starting subtest: bad-pitch-65536 [115.224283] Subtest bad-pitch-65536: SUCCESS (0.001s) [115.515070] [072/162] (908s left) kms_addfb_basic (bad-pitch-999) [115.574131] Starting subtest: bad-pitch-999 [115.575252] Subtest bad-pitch-999: SUCCESS (0.000s) [115.878797] [073/162] (907s left) kms_addfb_basic (basic) [115.939863] Starting subtest: basic [115.941434] Subtest basic: SUCCESS (0.000s) [116.228762] [074/162] (907s left) kms_addfb_basic (basic-x-tiled-legacy) [116.288745] Starting subtest: basic-x-tiled-legacy [116.289844] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.584459] [075/162] (907s left) kms_addfb_basic (basic-y-tiled-legacy) [116.644230] Starting subtest: basic-y-tiled-legacy [116.645216] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [116.943093] [076/162] (907s left) kms_addfb_basic (bo-too-small) [117.223525] Starting subtest: bo-too-small [117.224678] Subtest bo-too-small: SUCCESS (0.000s) [117.308217] [077/162] (906s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.578471] Starting subtest: bo-too-small-due-to-tiling [117.579594] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [117.680397] [078/162] (906s left) kms_addfb_basic (clobberred-modifier) [117.740502] Starting subtest: clobberred-modifier [117.741478] Subtest clobberred-modifier: SUCCESS (0.000s) [118.047018] [079/162] (906s left) kms_addfb_basic (framebuffer-vs-set-tiling) [118.108503] Starting subtest: framebuffer-vs-set-tiling [118.109393] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [118.447734] [080/162] (905s left) kms_addfb_basic (invalid-get-prop) [118.509779] Starting subtest: invalid-get-prop [118.511324] Subtest invalid-get-prop: SUCCESS (0.000s) [118.834963] [081/162] (905s left) kms_addfb_basic (invalid-get-prop-any) [118.893776] Starting subtest: invalid-get-prop-any [118.894886] Subtest invalid-get-prop-any: SUCCESS (0.000s) [119.236124] [082/162] (905s left) kms_addfb_basic (invalid-set-prop) [119.296322] Starting subtest: invalid-set-prop [119.297236] Subtest invalid-set-prop: SUCCESS (0.000s) [119.621129] [083/162] (904s left) kms_addfb_basic (invalid-set-prop-any) [119.681079] Starting subtest: invalid-set-prop-any [119.682127] Subtest invalid-set-prop-any: SUCCESS (0.000s) [120.011798] [084/162] (904s left) kms_addfb_basic (no-handle) [120.070931] Starting subtest: no-handle [120.071993] Subtest no-handle: SUCCESS (0.000s) [120.396801] [085/162] (904s left) kms_addfb_basic (size-max) [120.695749] Starting subtest: size-max [120.697452] Subtest size-max: SUCCESS (0.001s) [120.788258] [086/162] (903s left) kms_addfb_basic (small-bo) [121.086967] Starting subtest: small-bo [121.088850] Subtest small-bo: SUCCESS (0.000s) [121.194946] [087/162] (903s left) kms_addfb_basic (tile-pitch-mismatch) [121.255260] Starting subtest: tile-pitch-mismatch [121.256284] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [121.597615] [088/162] (903s left) kms_addfb_basic (too-high) [121.895760] Starting subtest: too-high [121.897852] Subtest too-high: SUCCESS (0.004s) [121.982909] [089/162] (902s left) kms_addfb_basic (too-wide) [122.265657] Starting subtest: too-wide [122.267903] Subtest too-wide: SUCCESS (0.000s) [122.352583] [090/162] (902s left) kms_addfb_basic (unused-handle) [122.412129] Starting subtest: unused-handle [122.413177] Subtest unused-handle: SUCCESS (0.000s) [122.751603] [091/162] (902s left) kms_addfb_basic (unused-modifier) [122.811622] Starting subtest: unused-modifier [122.812652] Subtest unused-modifier: SUCCESS (0.000s) [123.137423] [092/162] (901s left) kms_addfb_basic (unused-offsets) [123.197467] Starting subtest: unused-offsets [123.198469] Subtest unused-offsets: SUCCESS (0.000s) [123.535347] [093/162] (901s left) kms_addfb_basic (unused-pitches) [123.596275] Starting subtest: unused-pitches [123.597294] Subtest unused-pitches: SUCCESS (0.000s) [123.920409] [094/162] (901s left) kms_busy (basic) [124.208163] Subtest basic: SKIP (0.000s) [124.269731] [095/162] (900s left) kms_prop_blob (basic) [124.330622] Starting subtest: basic [124.332093] Subtest basic: SUCCESS (0.000s) [124.391187] [096/162] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [124.677890] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [124.740148] [097/162] (900s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [125.022376] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [125.082730] [098/162] (900s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [125.358855] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [125.420411] [099/162] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [125.698569] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [125.756790] [100/162] (899s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [126.036180] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [126.105299] [101/162] (899s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [126.391570] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [126.452446] [102/162] (899s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [126.735755] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [126.797140] [103/162] (898s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [127.082208] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [127.139925] [104/162] (898s left) kms_dsc (dsc-basic) [127.413117] Subtest dsc-basic: SKIP (0.000s) [127.486531] [105/162] (898s left) kms_flip (basic-flip-vs-dpms) [127.761334] Starting subtest: basic-flip-vs-dpms [127.765380] Subtest basic-flip-vs-dpms: SKIP (0.002s) [127.839230] [106/162] (898s left) kms_flip (basic-flip-vs-modeset) [128.112540] Starting subtest: basic-flip-vs-modeset [128.114801] Subtest basic-flip-vs-modeset: SKIP (0.002s) [128.188344] [107/162] (897s left) kms_flip (basic-flip-vs-wf_vblank) [128.490421] Starting subtest: basic-flip-vs-wf_vblank [128.493327] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [128.561720] [108/162] (897s left) kms_flip (basic-plain-flip) [128.848105] Starting subtest: basic-plain-flip [128.852829] Subtest basic-plain-flip: SKIP (0.005s) [128.928676] [109/162] (897s left) kms_force_connector_basic (force-connector-state) [129.323269] Starting subtest: force-connector-state [130.052015] Subtest force-connector-state: SUCCESS (0.729s) [130.432859] [110/162] (895s left) kms_force_connector_basic (force-edid) [130.825080] Starting subtest: force-edid [131.589777] Subtest force-edid: SUCCESS (0.765s) [132.213232] [111/162] (894s left) kms_force_connector_basic (force-load-detect) [132.611498] Starting subtest: force-load-detect [132.613818] Subtest force-load-detect: SKIP (0.000s) [133.008137] [112/162] (893s left) kms_force_connector_basic (prune-stale-modes) [133.392267] Starting subtest: prune-stale-modes [134.127926] Subtest prune-stale-modes: SUCCESS (0.737s) [134.668915] [113/162] (891s left) kms_frontbuffer_tracking (basic) [134.965782] Subtest basic: SKIP (0.000s) [135.039864] [114/162] (891s left) kms_hdmi_inject (inject-audio) [135.104786] Starting subtest: inject-audio [135.781367] Subtest inject-audio: SUCCESS (0.675s) [136.117821] [115/162] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [136.414861] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [136.493531] [116/162] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [136.783550] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [136.855511] [117/162] (889s left) kms_pipe_crc_basic (hang-read-crc) [137.172661] Subtest hang-read-crc: SKIP (0.000s) [137.238800] [118/162] (889s left) kms_pipe_crc_basic (nonblocking-crc) [137.530589] Subtest nonblocking-crc: SKIP (0.000s) [137.607105] [119/162] (889s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [137.905563] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [137.976344] [120/162] (888s left) kms_pipe_crc_basic (read-crc) [138.264955] Subtest read-crc: SKIP (0.000s) [138.348419] [121/162] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence) [138.645566] Subtest read-crc-frame-sequence: SKIP (0.000s) [138.717905] [122/162] (888s left) kms_pm_backlight (basic-brightness) [139.015975] Subtest basic-brightness: SKIP (0.000s) [139.112834] [123/162] (887s left) kms_pm_rpm (basic-pci-d3-state) [140.835610] Starting subtest: basic-pci-d3-state [141.162300] Subtest basic-pci-d3-state: SUCCESS (0.328s) [141.343446] [124/162] (885s left) kms_pm_rpm (basic-rte) [141.626463] Starting subtest: basic-rte [143.548317] Subtest basic-rte: SUCCESS (1.922s) [144.075268] [125/162] (883s left) kms_psr (psr-primary-page-flip) [144.470053] Subtest psr-primary-page-flip: SKIP (0.000s) [144.540783] [126/162] (882s left) kms_psr (psr-cursor-plane-move) [144.807142] Subtest psr-cursor-plane-move: SKIP (0.000s) [144.875317] [127/162] (882s left) kms_psr (psr-sprite-plane-onoff) [145.148536] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [145.215399] [128/162] (882s left) kms_psr (psr-primary-mmap-gtt) [145.500167] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [145.577379] [129/162] (881s left) kms_setmode (basic-clone-single-crtc) [145.637603] Starting subtest: basic-clone-single-crtc [145.640627] Subtest basic-clone-single-crtc: SKIP (0.000s) [145.703603] [130/162] (881s left) i915_pm_rps (basic-api) [145.780793] Starting subtest: basic-api [145.785499] Subtest basic-api: SUCCESS (0.005s) [145.866503] [131/162] (881s left) prime_self_import (basic-llseek-bad) [145.925295] Starting subtest: basic-llseek-bad [145.927445] Subtest basic-llseek-bad: SUCCESS (0.003s) [146.009965] [132/162] (881s left) prime_self_import (basic-llseek-size) [146.065213] Starting subtest: basic-llseek-size [146.069983] Subtest basic-llseek-size: SUCCESS (0.005s) [146.158772] [133/162] (881s left) prime_self_import (basic-with_fd_dup) [146.217101] Starting subtest: basic-with_fd_dup [146.221299] Subtest basic-with_fd_dup: SUCCESS (0.005s) [146.301084] [134/162] (881s left) prime_self_import (basic-with_one_bo) [146.358127] Starting subtest: basic-with_one_bo [146.362412] Subtest basic-with_one_bo: SUCCESS (0.005s) [146.430756] [135/162] (881s left) prime_self_import (basic-with_one_bo_two_files) [146.487241] Starting subtest: basic-with_one_bo_two_files [146.491387] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [146.571670] [136/162] (881s left) prime_self_import (basic-with_two_bos) [146.629278] Starting subtest: basic-with_two_bos [146.632666] Subtest basic-with_two_bos: SUCCESS (0.004s) [146.726562] [137/162] (881s left) prime_vgem (basic-fence-flip) [146.796632] Starting subtest: basic-fence-flip [147.014072] Subtest basic-fence-flip: SKIP (0.215s) [147.088820] [138/162] (880s left) prime_vgem (basic-fence-mmap) [147.163582] Starting subtest: basic-fence-mmap [147.201297] Subtest basic-fence-mmap: SUCCESS (0.038s) [147.293334] [139/162] (880s left) prime_vgem (basic-fence-read) [147.362579] Starting subtest: basic-fence-read [147.438486] Subtest basic-fence-read: SUCCESS (0.076s) [147.507481] [140/162] (880s left) prime_vgem (basic-gtt) [147.577532] Starting subtest: basic-gtt [147.596460] Subtest basic-gtt: SUCCESS (0.019s) [147.688708] [141/162] (880s left) prime_vgem (basic-read) [147.763411] Starting subtest: basic-read [147.802561] Subtest basic-read: SUCCESS (0.039s) [147.893906] [142/162] (880s left) prime_vgem (basic-write) [147.965296] Starting subtest: basic-write [148.001860] Subtest basic-write: SUCCESS (0.037s) [148.071671] [143/162] (880s left) vgem_basic (setversion) [148.133362] Starting subtest: setversion [148.135771] Subtest setversion: SUCCESS (0.000s) [148.199483] [144/162] (880s left) vgem_basic (create) [148.260764] Starting subtest: create [148.261759] Subtest create: SUCCESS (0.000s) [148.320189] [145/162] (880s left) vgem_basic (debugfs) [148.381946] Starting subtest: debugfs [148.382940] Subtest debugfs: SUCCESS (0.001s) [148.446251] [146/162] (880s left) vgem_basic (dmabuf-export) [148.507147] Starting subtest: dmabuf-export [148.510366] Subtest dmabuf-export: SUCCESS (0.003s) [148.598243] [147/162] (879s left) vgem_basic (dmabuf-fence) [148.660309] Starting subtest: dmabuf-fence [148.661306] Subtest dmabuf-fence: SUCCESS (0.001s) [148.720931] [148/162] (879s left) vgem_basic (dmabuf-fence-before) [148.781953] Starting subtest: dmabuf-fence-before [148.783315] Subtest dmabuf-fence-before: SUCCESS (0.001s) [148.842290] [149/162] (879s left) vgem_basic (dmabuf-mmap) [148.903381] Starting subtest: dmabuf-mmap [148.916551] Subtest dmabuf-mmap: SUCCESS (0.014s) [148.985627] [150/162] (879s left) vgem_basic (mmap) [149.046742] Starting subtest: mmap [149.056831] Subtest mmap: SUCCESS (0.011s) [149.118777] [151/162] (879s left) vgem_basic (second-client) [149.179267] Starting subtest: second-client [149.185135] Subtest second-client: SUCCESS (0.006s) [149.249409] [152/162] (879s left) vgem_basic (sysfs) [149.312136] Starting subtest: sysfs [149.313216] Subtest sysfs: SUCCESS (0.001s) [149.374587] [153/162] (879s left) core_hotunplug (unbind-rebind) [149.487354] Starting subtest: unbind-rebind [153.684655] Subtest unbind-rebind: SUCCESS (4.193s) [153.741056] [154/162] (875s left) vgem_basic (unload) [153.805312] Starting subtest: unload [182.791021] Subtest unload: SUCCESS (28.929s) [182.848574] [155/162] (846s left) i915_module_load (reload) [182.912761] Starting subtest: reload [186.481189] Subtest reload: SUCCESS (3.567s) [186.583527] [156/162] (842s left) gem_lmem_swapping (basic) [186.782625] Subtest basic: SKIP (0.000s) [186.889583] [157/162] (842s left) gem_lmem_swapping (parallel-random-engines) [186.958179] Subtest parallel-random-engines: SKIP (0.000s) [187.014579] [158/162] (842s left) gem_lmem_swapping (random-engines) [187.080058] Subtest random-engines: SKIP (0.000s) [187.137874] [159/162] (842s left) gem_lmem_swapping (verify-random) [187.203987] Subtest verify-random: SKIP (0.000s) [187.260998] [160/162] (842s left) i915_pm_rpm (module-reload) [189.958242] Starting subtest: module-reload [204.568451] Subtest module-reload: SUCCESS (14.558s) [204.635485] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [204.637145] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [204.640182] [161/162] (824s left) i915_selftest (live) [204.712462] Starting subtest: live [204.713889] Starting dynamic subtest: sanitycheck [207.500266] Dynamic subtest sanitycheck: SUCCESS (2.766s) [207.515313] Starting dynamic subtest: uncore [210.393154] Dynamic subtest uncore: SUCCESS (2.856s) [210.408524] Starting dynamic subtest: workarounds [213.400103] Dynamic subtest workarounds: SUCCESS (3.006s) [213.412030] Starting dynamic subtest: gt_engines [216.631100] Dynamic subtest gt_engines: SUCCESS (3.230s) [216.646451] Starting dynamic subtest: gt_timelines [232.669191] Dynamic subtest gt_timelines: SUCCESS (16.037s) [232.681083] Starting dynamic subtest: gt_contexts [235.551770] Dynamic subtest gt_contexts: SUCCESS (2.904s) [235.591628] Starting dynamic subtest: gt_lrc [241.530352] Dynamic subtest gt_lrc: SUCCESS (5.953s) [241.542399] Starting dynamic subtest: gt_mocs [244.383248] Dynamic subtest gt_mocs: SUCCESS (2.852s) [244.395183] Starting dynamic subtest: gt_pm [255.725259] Dynamic subtest gt_pm: SUCCESS (11.341s) [255.737207] Starting dynamic subtest: gt_heartbeat [258.458172] Dynamic subtest gt_heartbeat: SUCCESS (2.731s) [258.470169] Starting dynamic subtest: gt_tlb [262.901191] Dynamic subtest gt_tlb: SUCCESS (4.442s) [262.913264] Starting dynamic subtest: requests [273.111507] Dynamic subtest requests: SUCCESS (10.209s) [273.123544] Starting dynamic subtest: migrate [278.832055] Dynamic subtest migrate: SUCCESS (5.719s) [278.844285] Starting dynamic subtest: active [281.538893] Dynamic subtest active: SUCCESS (2.706s) [281.554443] Starting dynamic subtest: objects [285.175883] Dynamic subtest objects: SUCCESS (3.635s) [285.187828] Starting dynamic subtest: mman [291.443091] Dynamic subtest mman: SUCCESS (6.266s) [291.458633] Starting dynamic subtest: dmabuf [294.169096] Dynamic subtest dmabuf: SUCCESS (2.724s) [294.184582] Starting dynamic subtest: vma [296.880042] Dynamic subtest vma: SUCCESS (2.709s) [296.892246] Starting dynamic subtest: coherency [300.790355] Dynamic subtest coherency: SUCCESS (3.909s) [300.802612] Starting dynamic subtest: gtt [310.772059] Dynamic subtest gtt: SUCCESS (9.980s) [310.784175] Starting dynamic subtest: gem [314.012961] Dynamic subtest gem: SUCCESS (3.239s) [314.025052] Starting dynamic subtest: evict [319.037165] Dynamic subtest evict: SUCCESS (5.022s) [319.052809] Starting dynamic subtest: hugepages [328.233137] Dynamic subtest hugepages: SUCCESS (9.194s) [328.245247] Starting dynamic subtest: gem_contexts [348.260490] Dynamic subtest gem_contexts: SUCCESS (20.025s) [348.275233] Starting dynamic subtest: client [351.030221] Dynamic subtest client: SUCCESS (2.768s) [351.042304] Starting dynamic subtest: gem_migrate [353.766121] Dynamic subtest gem_migrate: SUCCESS (2.734s) [353.778357] Starting dynamic subtest: reset [356.896957] Dynamic subtest reset: SUCCESS (3.129s) [356.912639] Starting dynamic subtest: memory_region [359.603157] Dynamic subtest memory_region: SUCCESS (2.704s) [359.615254] Starting dynamic subtest: hangcheck [391.015995] Dynamic subtest hangcheck: SUCCESS (31.410s) [391.031647] Starting dynamic subtest: execlists [406.872670] Dynamic subtest execlists: SUCCESS (15.854s) [406.884883] Starting dynamic subtest: ring_submission [409.568375] Dynamic subtest ring_submission: SUCCESS (2.693s) [409.583729] Starting dynamic subtest: perf [412.343953] Dynamic subtest perf: SUCCESS (2.774s) [412.359645] Starting dynamic subtest: slpc [415.057098] Dynamic subtest slpc: SUCCESS (2.711s) [415.072840] Starting dynamic subtest: guc [417.752095] Dynamic subtest guc: SUCCESS (2.693s) [417.764236] Starting dynamic subtest: guc_multi_lrc [420.469094] Dynamic subtest guc_multi_lrc: SUCCESS (2.715s) [420.481229] Starting dynamic subtest: guc_hang [423.143455] Dynamic subtest guc_hang: SUCCESS (2.672s) [423.159009] Starting dynamic subtest: late_gt_pm [425.897522] Dynamic subtest late_gt_pm: SUCCESS (2.752s) [425.900088] Subtest live: SUCCESS (221.124s) [425.969265] [162/162] (603s left) dmabuf (all-tests) [426.042581] Starting subtest: all-tests [426.044732] Subtest all-tests: SKIP (0.000s) [426.085532] 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.