[31.656755] Initializing watchdogs [31.656863] /dev/watchdog0 [31.679435] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [31.686014] [001/161] (960s left) i915_module_load (load) [31.766584] Starting subtest: load [34.002987] Subtest load: SUCCESS (2.236s) [34.056796] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [34.060407] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [34.066769] [002/161] (958s left) core_auth (basic-auth) [34.176734] Starting subtest: basic-auth [34.178655] Subtest basic-auth: SUCCESS (0.001s) [34.232478] [003/161] (958s left) debugfs_test (read_all_entries) [34.311017] Starting subtest: read_all_entries [34.354883] Subtest read_all_entries: SUCCESS (0.044s) [34.635756] [004/161] (957s left) debugfs_test (basic-hwmon) [34.709677] Starting subtest: basic-hwmon [34.712884] Subtest basic-hwmon: SKIP (0.000s) [34.966020] [005/161] (957s left) debugfs_test (sysfs) [35.039209] Starting subtest: sysfs [35.115207] Subtest sysfs: SUCCESS (0.076s) [35.388873] [006/161] (957s left) fbdev (eof) [35.467580] Subtest eof: SKIP (0.000s) [35.512423] [007/161] (957s left) fbdev (info) [35.588156] Subtest info: SKIP (0.000s) [35.632648] [008/161] (956s left) fbdev (nullptr) [35.707170] Subtest nullptr: SKIP (0.000s) [35.751833] [009/161] (956s left) fbdev (read) [35.829360] Subtest read: SKIP (0.000s) [35.873115] [010/161] (956s left) fbdev (write) [35.950058] Subtest write: SKIP (0.000s) [35.994121] [011/161] (956s left) gem_basic (bad-close) [36.060439] Starting subtest: bad-close [36.062300] Subtest bad-close: SUCCESS (0.000s) [36.107566] [012/161] (956s left) gem_basic (create-close) [36.174665] Starting subtest: create-close [36.176803] Subtest create-close: SUCCESS (0.000s) [36.244484] [013/161] (956s left) gem_basic (create-fd-close) [36.309873] Starting subtest: create-fd-close [36.311990] Subtest create-fd-close: SUCCESS (0.000s) [36.373803] [014/161] (956s left) gem_busy (busy@all-engines) [36.458864] Starting subtest: busy [36.459975] Starting dynamic subtest: all-engines [36.529902] Dynamic subtest all-engines: SUCCESS (0.071s) [36.531103] Subtest busy: SUCCESS (0.071s) [36.910760] [015/161] (956s left) gem_close_race (basic-process) [37.002383] Starting subtest: basic-process [37.076134] Subtest basic-process: SUCCESS (0.073s) [37.319433] [016/161] (955s left) gem_close_race (basic-threads) [37.408254] Starting subtest: basic-threads [38.691483] Subtest basic-threads: SUCCESS (1.254s) [38.868448] [017/161] (954s left) gem_ctx_create (basic) [38.955834] Starting subtest: basic [38.957166] Subtest basic: SUCCESS (0.000s) [39.146510] [018/161] (954s left) gem_ctx_create (basic-files) [39.233392] Starting subtest: basic-files [41.253439] Subtest basic-files: SUCCESS (2.020s) [41.495328] [019/161] (951s left) gem_ctx_exec (basic) [41.570088] Starting subtest: basic [41.578871] Subtest basic: SUCCESS (0.008s) [41.658790] [020/161] (951s left) gem_exec_basic (basic) [41.741990] Starting subtest: basic [41.743479] Starting dynamic subtest: rcs0-smem [41.746169] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [41.756356] Starting dynamic subtest: bcs0-smem [41.757681] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [41.765922] Starting dynamic subtest: vcs0-smem [41.767288] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [41.775545] Starting dynamic subtest: vcs1-smem [41.776840] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [41.785065] Starting dynamic subtest: vecs0-smem [41.786375] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [41.787667] Subtest basic: SUCCESS (0.008s) [41.983029] [021/161] (951s left) gem_exec_create (basic) [42.138187] Starting subtest: basic [42.139308] Starting dynamic subtest: smem [44.155211] Dynamic subtest smem: SUCCESS (2.050s) [44.156682] Subtest basic: SUCCESS (2.050s) [44.298720] [022/161] (949s left) gem_exec_fence (basic-busy) [44.542696] Starting subtest: basic-busy [44.544549] Starting dynamic subtest: rcs0 [44.576606] Dynamic subtest rcs0: SUCCESS (0.034s) [44.587051] Starting dynamic subtest: bcs0 [44.607480] Dynamic subtest bcs0: SUCCESS (0.031s) [44.617307] Starting dynamic subtest: vcs0 [44.631606] Dynamic subtest vcs0: SUCCESS (0.024s) [44.641977] Starting dynamic subtest: vcs1 [44.654676] Dynamic subtest vcs1: SUCCESS (0.023s) [44.665544] Starting dynamic subtest: vecs0 [44.680710] Dynamic subtest vecs0: SUCCESS (0.026s) [44.681983] Subtest basic-busy: SUCCESS (0.139s) [45.378315] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [45.381187] [023/161] (948s left) gem_exec_fence (basic-wait) [45.614740] Starting subtest: basic-wait [45.616112] Starting dynamic subtest: rcs0 [45.654861] Dynamic subtest rcs0: SUCCESS (0.040s) [45.664700] Starting dynamic subtest: bcs0 [45.678539] Dynamic subtest bcs0: SUCCESS (0.023s) [45.689017] Starting dynamic subtest: vcs0 [45.701208] Dynamic subtest vcs0: SUCCESS (0.022s) [45.710095] Starting dynamic subtest: vcs1 [45.725481] Dynamic subtest vcs1: SUCCESS (0.025s) [45.734580] Starting dynamic subtest: vecs0 [45.747459] Dynamic subtest vecs0: SUCCESS (0.022s) [45.748601] Subtest basic-wait: SUCCESS (0.133s) [46.405365] [024/161] (947s left) gem_exec_fence (basic-await) [46.640170] Starting subtest: basic-await [46.642435] Starting dynamic subtest: rcs0 [46.817953] Dynamic subtest rcs0: SUCCESS (0.123s) [46.827979] Starting dynamic subtest: bcs0 [46.877247] Dynamic subtest bcs0: SUCCESS (0.115s) [46.889927] Starting dynamic subtest: vcs0 [47.000792] Dynamic subtest vcs0: SUCCESS (0.115s) [47.012066] Starting dynamic subtest: vcs1 [47.123987] Dynamic subtest vcs1: SUCCESS (0.124s) [47.135658] Starting dynamic subtest: vecs0 [47.246360] Dynamic subtest vecs0: SUCCESS (0.126s) [47.247697] Subtest basic-await: SUCCESS (0.606s) [47.910361] [025/161] (945s left) gem_exec_fence (nb-await) [48.157506] Starting subtest: nb-await [48.158696] Starting dynamic subtest: rcs0 [48.225522] Dynamic subtest rcs0: SUCCESS (0.068s) [48.241650] Starting dynamic subtest: bcs0 [48.296334] Dynamic subtest bcs0: SUCCESS (0.069s) [48.322898] Starting dynamic subtest: vcs0 [48.374791] Dynamic subtest vcs0: SUCCESS (0.078s) [48.406550] Starting dynamic subtest: vcs1 [48.460338] Dynamic subtest vcs1: SUCCESS (0.085s) [48.485712] Starting dynamic subtest: vecs0 [48.538254] Dynamic subtest vecs0: SUCCESS (0.077s) [48.546108] Subtest nb-await: SUCCESS (0.380s) [49.270076] [026/161] (944s left) gem_exec_gttfill (basic) [49.362745] Starting subtest: basic [58.473082] Subtest basic: SUCCESS (9.180s) [58.606685] [027/161] (935s left) gem_exec_parallel (engines) [59.057789] Starting subtest: engines [59.059068] Starting dynamic subtest: basic [61.986903] Dynamic subtest basic: SUCCESS (2.906s) [61.997301] Starting dynamic subtest: contexts [69.495818] Dynamic subtest contexts: SUCCESS (7.583s) [69.506938] Starting dynamic subtest: fds [76.393186] Dynamic subtest fds: SUCCESS (6.895s) [76.403306] Starting dynamic subtest: userptr [79.492966] Dynamic subtest userptr: SUCCESS (3.070s) [79.494889] Subtest engines: SUCCESS (20.455s) [79.647109] [028/161] (914s left) gem_exec_store (basic) [79.741709] Starting subtest: basic [79.794673] Subtest basic: SUCCESS (0.054s) [79.989336] [029/161] (913s left) gem_flink_basic (bad-flink) [80.056338] Starting subtest: bad-flink [80.057506] Subtest bad-flink: SUCCESS (0.000s) [80.108648] [030/161] (913s left) gem_flink_basic (bad-open) [80.175523] Starting subtest: bad-open [80.176679] Subtest bad-open: SUCCESS (0.000s) [80.227448] [031/161] (913s left) gem_flink_basic (basic) [80.462529] Starting subtest: basic [80.463789] Subtest basic: SUCCESS (0.001s) [80.513779] [032/161] (913s left) gem_flink_basic (double-flink) [80.579355] Starting subtest: double-flink [80.580385] Subtest double-flink: SUCCESS (0.000s) [80.652840] [033/161] (913s left) gem_flink_basic (flink-lifetime) [80.717284] Starting subtest: flink-lifetime [80.719634] Subtest flink-lifetime: SUCCESS (0.002s) [80.790644] [034/161] (913s left) gem_huc_copy (huc-copy) [80.866801] Starting subtest: huc-copy [80.868980] Subtest huc-copy: SKIP (0.000s) [80.939149] [035/161] (913s left) gem_linear_blits (basic) [81.117730] Starting subtest: basic [81.180343] Subtest basic: SUCCESS (0.019s) [81.359700] [036/161] (912s left) gem_mmap (basic) [81.525221] Starting subtest: basic [81.530186] Subtest basic: SUCCESS (0.000s) [81.594734] [037/161] (912s left) gem_mmap_gtt (basic) [81.660808] Starting subtest: basic [81.661980] Subtest basic: SUCCESS (0.001s) [81.714425] [038/161] (912s left) gem_render_linear_blits (basic) [81.787248] Starting subtest: basic [81.820785] Subtest basic: SUCCESS (0.034s) [81.881894] [039/161] (912s left) gem_render_tiled_blits (basic) [81.955628] Starting subtest: basic [81.998994] Subtest basic: SUCCESS (0.043s) [82.063917] [040/161] (912s left) gem_ringfill (basic-all) [82.345131] Starting subtest: basic-all [83.581668] Subtest basic-all: SUCCESS (1.181s) [83.640674] [041/161] (910s left) gem_softpin (allocator-basic) [83.717433] Starting subtest: allocator-basic [83.899566] Subtest allocator-basic: SUCCESS (0.125s) [83.951264] [042/161] (910s left) gem_softpin (allocator-basic-reserve) [84.028760] Starting subtest: allocator-basic-reserve [84.210138] Subtest allocator-basic-reserve: SUCCESS (0.125s) [84.258113] [043/161] (910s left) gem_softpin (safe-alignment) [84.339697] Starting subtest: safe-alignment [84.355922] Subtest safe-alignment: SUCCESS (0.016s) [84.435459] [044/161] (910s left) gem_sync (basic-all) [84.526021] Starting subtest: basic-all [87.049819] Subtest basic-all: SUCCESS (2.488s) [87.216765] [045/161] (907s left) gem_sync (basic-each) [87.307258] Starting subtest: basic-each [89.535955] Subtest basic-each: SUCCESS (2.228s) [89.784608] [046/161] (905s left) gem_tiled_blits (basic) [89.944606] Starting subtest: basic [89.971082] Subtest basic: SUCCESS (0.024s) [90.096479] [047/161] (904s left) gem_tiled_fence_blits (basic) [90.698021] Starting subtest: basic [90.710260] Subtest basic: SUCCESS (0.013s) [90.818334] [048/161] (904s left) gem_tiled_pread_basic [91.175721] [049/161] (904s left) gem_wait (busy@all-engines) [91.273450] Starting subtest: busy [91.274669] Starting dynamic subtest: all-engines [91.846854] Dynamic subtest all-engines: SUCCESS (0.572s) [91.849060] Subtest busy: SUCCESS (0.573s) [92.133330] [050/161] (903s left) gem_wait (wait@all-engines) [92.227284] Starting subtest: wait [92.228530] Starting dynamic subtest: all-engines [93.315618] Dynamic subtest all-engines: SUCCESS (1.038s) [93.318606] Subtest wait: SUCCESS (1.039s) [93.490771] [051/161] (901s left) i915_getparams_basic (basic-eu-total) [93.558940] Starting subtest: basic-eu-total [93.561263] Subtest basic-eu-total: SUCCESS (0.000s) [93.618150] [052/161] (901s left) i915_getparams_basic (basic-subslice-total) [93.691283] Starting subtest: basic-subslice-total [93.694125] Subtest basic-subslice-total: SUCCESS (0.000s) [93.744229] [053/161] (901s left) i915_hangman (error-state-basic) [93.826776] Starting subtest: error-state-basic [93.833501] Subtest error-state-basic: SUCCESS (0.006s) [94.043345] [054/161] (901s left) i915_pciid [94.210600] [055/161] (901s left) kms_addfb_basic (addfb25-4-tiled) [94.479907] Starting subtest: addfb25-4-tiled [94.482281] Subtest addfb25-4-tiled: SUCCESS (0.001s) [94.568434] [056/161] (901s left) kms_addfb_basic (addfb25-bad-modifier) [94.827684] Starting subtest: addfb25-bad-modifier [94.829831] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [94.931996] [057/161] (900s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [95.192654] Starting subtest: addfb25-framebuffer-vs-set-tiling [95.194322] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [95.289952] [058/161] (900s left) kms_addfb_basic (addfb25-modifier-no-flag) [95.549984] Starting subtest: addfb25-modifier-no-flag [95.552611] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [95.660238] [059/161] (900s left) kms_addfb_basic (addfb25-x-tiled-legacy) [95.921250] Starting subtest: addfb25-x-tiled-legacy [95.923251] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [96.022511] [060/161] (899s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [96.283815] Starting subtest: addfb25-x-tiled-mismatch-legacy [96.285679] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [96.389044] [061/161] (899s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [96.658158] Starting subtest: addfb25-yf-tiled-legacy [96.660853] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [96.769517] [062/161] (899s left) kms_addfb_basic (addfb25-y-tiled-legacy) [97.025883] Starting subtest: addfb25-y-tiled-legacy [97.027299] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [97.128896] [063/161] (899s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [97.383818] Starting subtest: addfb25-y-tiled-small-legacy [97.385888] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [97.496658] [064/161] (898s left) kms_addfb_basic (bad-pitch-0) [97.562175] Starting subtest: bad-pitch-0 [97.563247] Subtest bad-pitch-0: SUCCESS (0.000s) [97.863456] [065/161] (898s left) kms_addfb_basic (bad-pitch-1024) [97.929237] Starting subtest: bad-pitch-1024 [97.930285] Subtest bad-pitch-1024: SUCCESS (0.000s) [98.206512] [066/161] (898s left) kms_addfb_basic (bad-pitch-128) [98.272184] Starting subtest: bad-pitch-128 [98.273171] Subtest bad-pitch-128: SUCCESS (0.000s) [98.558379] [067/161] (897s left) kms_addfb_basic (bad-pitch-256) [98.624113] Starting subtest: bad-pitch-256 [98.625134] Subtest bad-pitch-256: SUCCESS (0.000s) [98.912809] [068/161] (897s left) kms_addfb_basic (bad-pitch-32) [98.980479] Starting subtest: bad-pitch-32 [98.981916] Subtest bad-pitch-32: SUCCESS (0.000s) [99.278798] [069/161] (897s left) kms_addfb_basic (bad-pitch-63) [99.348362] Starting subtest: bad-pitch-63 [99.349261] Subtest bad-pitch-63: SUCCESS (0.000s) [99.651904] [070/161] (897s left) kms_addfb_basic (bad-pitch-65536) [99.717202] Starting subtest: bad-pitch-65536 [99.718315] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.016416] [071/161] (896s left) kms_addfb_basic (bad-pitch-999) [100.081454] Starting subtest: bad-pitch-999 [100.082447] Subtest bad-pitch-999: SUCCESS (0.000s) [100.365219] [072/161] (896s left) kms_addfb_basic (basic) [100.431191] Starting subtest: basic [100.432682] Subtest basic: SUCCESS (0.000s) [100.733233] [073/161] (896s left) kms_addfb_basic (basic-x-tiled-legacy) [100.799112] Starting subtest: basic-x-tiled-legacy [100.800078] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [101.099732] [074/161] (895s left) kms_addfb_basic (basic-y-tiled-legacy) [101.167385] Starting subtest: basic-y-tiled-legacy [101.168375] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [101.451719] [075/161] (895s left) kms_addfb_basic (bo-too-small) [101.706925] Starting subtest: bo-too-small [101.709379] Subtest bo-too-small: SUCCESS (0.001s) [101.813898] [076/161] (895s left) kms_addfb_basic (bo-too-small-due-to-tiling) [102.074647] Starting subtest: bo-too-small-due-to-tiling [102.076764] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [102.185886] [077/161] (894s left) kms_addfb_basic (clobberred-modifier) [102.250370] Starting subtest: clobberred-modifier [102.251409] Subtest clobberred-modifier: SUCCESS (0.000s) [102.534167] [078/161] (894s left) kms_addfb_basic (framebuffer-vs-set-tiling) [102.601229] Starting subtest: framebuffer-vs-set-tiling [102.602193] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.886565] [079/161] (894s left) kms_addfb_basic (invalid-get-prop) [102.951569] Starting subtest: invalid-get-prop [102.952610] Subtest invalid-get-prop: SUCCESS (0.000s) [103.247142] [080/161] (894s left) kms_addfb_basic (invalid-get-prop-any) [103.314831] Starting subtest: invalid-get-prop-any [103.315911] Subtest invalid-get-prop-any: SUCCESS (0.000s) [103.598417] [081/161] (893s left) kms_addfb_basic (invalid-set-prop) [103.664753] Starting subtest: invalid-set-prop [103.665799] Subtest invalid-set-prop: SUCCESS (0.000s) [103.945264] [082/161] (893s left) kms_addfb_basic (invalid-set-prop-any) [104.011518] Starting subtest: invalid-set-prop-any [104.013081] Subtest invalid-set-prop-any: SUCCESS (0.000s) [104.312560] [083/161] (893s left) kms_addfb_basic (no-handle) [104.377454] Starting subtest: no-handle [104.378452] Subtest no-handle: SUCCESS (0.000s) [104.673351] [084/161] (892s left) kms_addfb_basic (size-max) [104.938933] Starting subtest: size-max [104.941490] Subtest size-max: SUCCESS (0.000s) [105.048282] [085/161] (892s left) kms_addfb_basic (small-bo) [105.308698] Starting subtest: small-bo [105.310447] Subtest small-bo: SUCCESS (0.000s) [105.431932] [086/161] (892s left) kms_addfb_basic (tile-pitch-mismatch) [105.497423] Starting subtest: tile-pitch-mismatch [105.498479] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [105.796647] [087/161] (892s left) kms_addfb_basic (too-high) [106.054361] Starting subtest: too-high [106.059418] Subtest too-high: SUCCESS (0.003s) [106.142370] [088/161] (891s left) kms_addfb_basic (too-wide) [106.397840] Starting subtest: too-wide [106.399323] Subtest too-wide: SUCCESS (0.000s) [106.488757] [089/161] (891s left) kms_addfb_basic (unused-handle) [106.554410] Starting subtest: unused-handle [106.555443] Subtest unused-handle: SUCCESS (0.000s) [106.853887] [090/161] (891s left) kms_addfb_basic (unused-modifier) [106.918501] Starting subtest: unused-modifier [106.919538] Subtest unused-modifier: SUCCESS (0.000s) [107.210129] [091/161] (890s left) kms_addfb_basic (unused-offsets) [107.274108] Starting subtest: unused-offsets [107.275104] Subtest unused-offsets: SUCCESS (0.000s) [107.575340] [092/161] (890s left) kms_addfb_basic (unused-pitches) [107.641810] Starting subtest: unused-pitches [107.642883] Subtest unused-pitches: SUCCESS (0.000s) [107.932366] [093/161] (890s left) kms_busy (basic) [108.201810] Subtest basic: SKIP (0.000s) [108.283306] [094/161] (890s left) kms_prop_blob (basic) [108.353009] Starting subtest: basic [108.353989] Subtest basic: SUCCESS (0.000s) [108.402808] [095/161] (889s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [108.672297] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [108.719819] [096/161] (889s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [108.989276] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [109.054172] [097/161] (889s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [109.327358] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [109.395702] [098/161] (889s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [109.669853] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [109.748826] [099/161] (888s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [110.025152] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [110.111464] [100/161] (888s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [110.378685] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [110.446741] [101/161] (888s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [110.713930] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [110.778447] [102/161] (888s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [111.038568] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [111.098088] [103/161] (887s left) kms_dsc (dsc-basic) [111.350196] Subtest dsc-basic: SKIP (0.000s) [111.418478] [104/161] (887s left) kms_flip (basic-flip-vs-dpms) [111.676168] Starting subtest: basic-flip-vs-dpms [111.680647] Subtest basic-flip-vs-dpms: SKIP (0.003s) [111.759592] [105/161] (887s left) kms_flip (basic-flip-vs-modeset) [112.015986] Starting subtest: basic-flip-vs-modeset [112.023667] Subtest basic-flip-vs-modeset: SKIP (0.007s) [112.103536] [106/161] (886s left) kms_flip (basic-flip-vs-wf_vblank) [112.361875] Starting subtest: basic-flip-vs-wf_vblank [112.368175] Subtest basic-flip-vs-wf_vblank: SKIP (0.005s) [112.458871] [107/161] (886s left) kms_flip (basic-plain-flip) [112.711132] Starting subtest: basic-plain-flip [112.717328] Subtest basic-plain-flip: SKIP (0.005s) [112.806026] [108/161] (886s left) kms_force_connector_basic (force-connector-state) [113.148105] Starting subtest: force-connector-state [113.816993] Subtest force-connector-state: SUCCESS (0.669s) [114.372012] [109/161] (884s left) kms_force_connector_basic (force-edid) [114.715372] Starting subtest: force-edid [115.250586] Subtest force-edid: SUCCESS (0.534s) [115.696423] [110/161] (883s left) kms_force_connector_basic (force-load-detect) [116.032021] Starting subtest: force-load-detect [116.034731] Subtest force-load-detect: SKIP (0.000s) [116.360816] [111/161] (883s left) kms_force_connector_basic (prune-stale-modes) [116.693223] Starting subtest: prune-stale-modes [117.275831] Subtest prune-stale-modes: SUCCESS (0.583s) [117.717775] [112/161] (881s left) kms_frontbuffer_tracking (basic) [117.982565] Subtest basic: SKIP (0.000s) [118.058468] [113/161] (881s left) kms_hdmi_inject (inject-audio) [118.128280] Starting subtest: inject-audio [118.661574] Subtest inject-audio: SUCCESS (0.530s) [118.920707] [114/161] (880s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [119.181796] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [119.261301] [115/161] (880s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [119.512316] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [119.587890] [116/161] (880s left) kms_pipe_crc_basic (hang-read-crc) [119.838929] Subtest hang-read-crc: SKIP (0.000s) [119.909441] [117/161] (879s left) kms_pipe_crc_basic (nonblocking-crc) [120.161203] Subtest nonblocking-crc: SKIP (0.000s) [120.235937] [118/161] (879s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [120.493043] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [120.561573] [119/161] (879s left) kms_pipe_crc_basic (read-crc) [120.821620] Subtest read-crc: SKIP (0.000s) [120.896765] [120/161] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence) [121.152181] Subtest read-crc-frame-sequence: SKIP (0.000s) [121.269260] [121/161] (878s left) kms_pm_backlight (basic-brightness) [121.571974] Subtest basic-brightness: SKIP (0.000s) [121.657934] [122/161] (878s left) kms_pm_rpm (basic-pci-d3-state) [123.294805] Starting subtest: basic-pci-d3-state [123.608165] Subtest basic-pci-d3-state: SUCCESS (0.298s) [123.782931] [123/161] (876s left) kms_pm_rpm (basic-rte) [123.870845] Starting subtest: basic-rte [125.721715] Subtest basic-rte: SUCCESS (1.857s) [126.193842] [124/161] (874s left) kms_psr (psr-primary-page-flip) [126.450850] Subtest psr-primary-page-flip: SKIP (0.000s) [126.542774] [125/161] (873s left) kms_psr (psr-cursor-plane-move) [126.804555] Subtest psr-cursor-plane-move: SKIP (0.000s) [126.884054] [126/161] (873s left) kms_psr (psr-sprite-plane-onoff) [127.141685] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [127.219036] [127/161] (873s left) kms_psr (psr-primary-mmap-gtt) [127.474256] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [127.550296] [128/161] (873s left) kms_setmode (basic-clone-single-crtc) [127.617449] Starting subtest: basic-clone-single-crtc [127.620504] Subtest basic-clone-single-crtc: SKIP (0.000s) [127.677966] [129/161] (872s left) i915_pm_rps (basic-api) [127.754242] Starting subtest: basic-api [127.758542] Subtest basic-api: SUCCESS (0.004s) [127.844253] [130/161] (872s left) prime_self_import (basic-llseek-bad) [127.911198] Starting subtest: basic-llseek-bad [127.913214] Subtest basic-llseek-bad: SUCCESS (0.003s) [127.995024] [131/161] (872s left) prime_self_import (basic-llseek-size) [128.058045] Starting subtest: basic-llseek-size [128.062355] Subtest basic-llseek-size: SUCCESS (0.005s) [128.140595] [132/161] (872s left) prime_self_import (basic-with_fd_dup) [128.205998] Starting subtest: basic-with_fd_dup [128.209747] Subtest basic-with_fd_dup: SUCCESS (0.003s) [128.286117] [133/161] (872s left) prime_self_import (basic-with_one_bo) [128.350813] Starting subtest: basic-with_one_bo [128.354157] Subtest basic-with_one_bo: SUCCESS (0.005s) [128.421872] [134/161] (872s left) prime_self_import (basic-with_one_bo_two_files) [128.485916] Starting subtest: basic-with_one_bo_two_files [128.490629] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [128.565843] [135/161] (872s left) prime_self_import (basic-with_two_bos) [128.628844] Starting subtest: basic-with_two_bos [128.632171] Subtest basic-with_two_bos: SUCCESS (0.004s) [128.712080] [136/161] (872s left) prime_vgem (basic-fence-flip) [128.791501] Starting subtest: basic-fence-flip [128.978969] Subtest basic-fence-flip: SKIP (0.183s) [129.055850] [137/161] (872s left) prime_vgem (basic-fence-mmap) [129.131575] Starting subtest: basic-fence-mmap [129.166237] Subtest basic-fence-mmap: SUCCESS (0.035s) [129.247709] [138/161] (871s left) prime_vgem (basic-fence-read) [129.324231] Starting subtest: basic-fence-read [129.395088] Subtest basic-fence-read: SUCCESS (0.070s) [129.457670] [139/161] (871s left) prime_vgem (basic-gtt) [129.552719] Starting subtest: basic-gtt [129.566832] Subtest basic-gtt: SUCCESS (0.014s) [129.644343] [140/161] (871s left) prime_vgem (basic-read) [129.719196] Starting subtest: basic-read [129.749858] Subtest basic-read: SUCCESS (0.031s) [129.835501] [141/161] (871s left) prime_vgem (basic-write) [129.910628] Starting subtest: basic-write [129.945921] Subtest basic-write: SUCCESS (0.035s) [130.009338] [142/161] (871s left) vgem_basic (setversion) [130.079306] Starting subtest: setversion [130.081247] Subtest setversion: SUCCESS (0.000s) [130.135500] [143/161] (871s left) vgem_basic (create) [130.203371] Starting subtest: create [130.204347] Subtest create: SUCCESS (0.000s) [130.260432] [144/161] (871s left) vgem_basic (debugfs) [130.328024] Starting subtest: debugfs [130.329089] Subtest debugfs: SUCCESS (0.000s) [130.383165] [145/161] (871s left) vgem_basic (dmabuf-export) [130.450292] Starting subtest: dmabuf-export [130.452338] Subtest dmabuf-export: SUCCESS (0.002s) [130.528852] [146/161] (871s left) vgem_basic (dmabuf-fence) [130.598686] Starting subtest: dmabuf-fence [130.600229] Subtest dmabuf-fence: SUCCESS (0.001s) [130.655395] [147/161] (870s left) vgem_basic (dmabuf-fence-before) [130.722340] Starting subtest: dmabuf-fence-before [130.723363] Subtest dmabuf-fence-before: SUCCESS (0.001s) [130.779059] [148/161] (870s left) vgem_basic (dmabuf-mmap) [130.848162] Starting subtest: dmabuf-mmap [130.859305] Subtest dmabuf-mmap: SUCCESS (0.013s) [130.918025] [149/161] (870s left) vgem_basic (mmap) [130.986616] Starting subtest: mmap [130.994437] Subtest mmap: SUCCESS (0.009s) [131.051748] [150/161] (870s left) vgem_basic (second-client) [131.119677] Starting subtest: second-client [131.123164] Subtest second-client: SUCCESS (0.003s) [131.180886] [151/161] (870s left) vgem_basic (sysfs) [131.248927] Starting subtest: sysfs [131.249948] Subtest sysfs: SUCCESS (0.001s) [131.308710] [152/161] (870s left) core_hotunplug (unbind-rebind) [131.425382] Starting subtest: unbind-rebind [135.755607] Subtest unbind-rebind: SUCCESS (4.331s) [135.813126] [153/161] (866s left) vgem_basic (unload) [135.876160] Starting subtest: unload [165.014409] Subtest unload: SUCCESS (29.081s) [165.066371] [154/161] (836s left) i915_module_load (reload) [165.134095] Starting subtest: reload [168.580693] Subtest reload: SUCCESS (3.446s) [168.672555] [155/161] (833s left) gem_lmem_swapping (basic) [168.842623] Subtest basic: SKIP (0.000s) [168.894733] [156/161] (833s left) gem_lmem_swapping (parallel-random-engines) [168.969157] Subtest parallel-random-engines: SKIP (0.000s) [169.022667] [157/161] (833s left) gem_lmem_swapping (random-engines) [169.097939] Subtest random-engines: SKIP (0.000s) [169.150601] [158/161] (833s left) gem_lmem_swapping (verify-random) [169.224265] Subtest verify-random: SKIP (0.000s) [169.276843] [159/161] (833s left) i915_pm_rpm (module-reload) [172.548199] Starting subtest: module-reload [187.072701] Subtest module-reload: SUCCESS (14.472s) [187.136318] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [187.138286] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [187.141376] [160/161] (815s left) i915_selftest (live) [187.216799] Starting subtest: live [187.218024] Starting dynamic subtest: sanitycheck [189.856394] Dynamic subtest sanitycheck: SUCCESS (2.583s) [189.865758] Starting dynamic subtest: uncore [192.509619] Dynamic subtest uncore: SUCCESS (2.652s) [192.520540] Starting dynamic subtest: workarounds [195.494313] Dynamic subtest workarounds: SUCCESS (2.984s) [195.505325] Starting dynamic subtest: gt_engines [198.617356] Dynamic subtest gt_engines: SUCCESS (3.121s) [198.628185] Starting dynamic subtest: gt_timelines [212.675089] Dynamic subtest gt_timelines: SUCCESS (14.056s) [212.685662] Starting dynamic subtest: gt_contexts [215.442329] Dynamic subtest gt_contexts: SUCCESS (2.766s) [215.451685] Starting dynamic subtest: gt_lrc [221.258452] Dynamic subtest gt_lrc: SUCCESS (5.814s) [221.267880] Starting dynamic subtest: gt_mocs [224.003408] Dynamic subtest gt_mocs: SUCCESS (2.744s) [224.013053] Starting dynamic subtest: gt_pm [235.258422] Dynamic subtest gt_pm: SUCCESS (11.253s) [235.267823] Starting dynamic subtest: gt_heartbeat [237.897176] Dynamic subtest gt_heartbeat: SUCCESS (2.638s) [237.906598] Starting dynamic subtest: gt_tlb [242.109463] Dynamic subtest gt_tlb: SUCCESS (4.211s) [242.118938] Starting dynamic subtest: requests [252.256293] Dynamic subtest requests: SUCCESS (10.145s) [252.265637] Starting dynamic subtest: migrate [257.806435] Dynamic subtest migrate: SUCCESS (5.549s) [257.815840] Starting dynamic subtest: active [260.435336] Dynamic subtest active: SUCCESS (2.628s) [260.444797] Starting dynamic subtest: objects [263.841179] Dynamic subtest objects: SUCCESS (3.404s) [263.850596] Starting dynamic subtest: mman [269.984453] Dynamic subtest mman: SUCCESS (6.142s) [269.993846] Starting dynamic subtest: dmabuf [272.669437] Dynamic subtest dmabuf: SUCCESS (2.683s) [272.678984] Starting dynamic subtest: vma [275.296192] Dynamic subtest vma: SUCCESS (2.624s) [275.305568] Starting dynamic subtest: coherency [280.140335] Dynamic subtest coherency: SUCCESS (4.843s) [280.149752] Starting dynamic subtest: gtt [290.422802] Dynamic subtest gtt: SUCCESS (10.279s) [290.432360] Starting dynamic subtest: gem [293.537571] Dynamic subtest gem: SUCCESS (3.112s) [293.548547] Starting dynamic subtest: evict [298.025351] Dynamic subtest evict: SUCCESS (4.486s) [298.034892] Starting dynamic subtest: hugepages [307.194464] Dynamic subtest hugepages: SUCCESS (9.166s) [307.203939] Starting dynamic subtest: gem_contexts [326.302744] Dynamic subtest gem_contexts: SUCCESS (19.106s) [326.312447] Starting dynamic subtest: client [328.996280] Dynamic subtest client: SUCCESS (2.691s) [329.005739] Starting dynamic subtest: gem_migrate [331.610307] Dynamic subtest gem_migrate: SUCCESS (2.611s) [331.621439] Starting dynamic subtest: reset [334.625927] Dynamic subtest reset: SUCCESS (3.013s) [334.635615] Starting dynamic subtest: memory_region [337.132159] Dynamic subtest memory_region: SUCCESS (2.558s) [337.157668] Starting dynamic subtest: hangcheck [368.576814] Dynamic subtest hangcheck: SUCCESS (31.388s) [368.586333] Starting dynamic subtest: execlists [384.082761] Dynamic subtest execlists: SUCCESS (15.502s) [384.092291] Starting dynamic subtest: ring_submission [386.676599] Dynamic subtest ring_submission: SUCCESS (2.589s) [386.687751] Starting dynamic subtest: perf [389.450065] Dynamic subtest perf: SUCCESS (2.771s) [389.459627] Starting dynamic subtest: slpc [392.065723] Dynamic subtest slpc: SUCCESS (2.611s) [392.077071] Starting dynamic subtest: guc [394.675568] Dynamic subtest guc: SUCCESS (2.607s) [394.686879] Starting dynamic subtest: guc_multi_lrc [397.295020] Dynamic subtest guc_multi_lrc: SUCCESS (2.617s) [397.304477] Starting dynamic subtest: guc_hang [399.912098] Dynamic subtest guc_hang: SUCCESS (2.615s) [399.921657] Starting dynamic subtest: late_gt_pm [402.551421] Dynamic subtest late_gt_pm: SUCCESS (2.637s) [402.553999] Subtest live: SUCCESS (215.279s) [402.618193] [161/161] (599s left) dmabuf (all-tests) [402.689917] Starting subtest: all-tests [402.691332] Starting dynamic subtest: sanitycheck [402.753939] Dynamic subtest sanitycheck: SUCCESS (0.063s) [402.783591] Starting dynamic subtest: dma_fence [402.962264] Dynamic subtest dma_fence: SUCCESS (0.205s) [402.991117] Starting dynamic subtest: dma_fence_chain [415.369896] Dynamic subtest dma_fence_chain: SUCCESS (12.348s) [415.392023] Starting dynamic subtest: dma_fence_unwrap [415.450367] Dynamic subtest dma_fence_unwrap: SUCCESS (0.132s) [415.484032] Starting dynamic subtest: dma_resv [415.542541] Dynamic subtest dma_resv: SUCCESS (0.087s) [415.544896] Subtest all-tests: SUCCESS (12.854s) [415.621340] Closing watchdogs results: parsing output: 0/ for test: i915_module_load results: parsing output: 1/ for test: core_auth results: parsing output: 2/ for test: debugfs_test results: parsing output: 3/ for test: debugfs_test results: parsing output: 4/ for test: debugfs_test results: parsing output: 5/ for test: fbdev results: parsing output: 6/ for test: fbdev results: parsing output: 7/ for test: fbdev results: parsing output: 8/ for test: fbdev results: parsing output: 9/ for test: fbdev results: parsing output: 10/ for test: gem_basic results: parsing output: 11/ for test: gem_basic results: parsing output: 12/ for test: gem_basic results: parsing output: 13/ for test: gem_busy results: parsing output: 14/ for test: gem_close_race results: parsing output: 15/ for test: gem_close_race results: parsing output: 16/ for test: gem_ctx_create results: parsing output: 17/ for test: gem_ctx_create results: parsing output: 18/ for test: gem_ctx_exec results: parsing output: 19/ for test: gem_exec_basic results: parsing output: 20/ for test: gem_exec_create results: parsing output: 21/ for test: gem_exec_fence results: parsing output: 22/ for test: gem_exec_fence results: parsing output: 23/ for test: gem_exec_fence results: parsing output: 24/ for test: gem_exec_fence results: parsing output: 25/ for test: gem_exec_gttfill results: parsing output: 26/ for test: gem_exec_parallel results: parsing output: 27/ for test: gem_exec_store results: parsing output: 28/ for test: gem_flink_basic results: parsing output: 29/ for test: gem_flink_basic results: parsing output: 30/ for test: gem_flink_basic results: parsing output: 31/ for test: gem_flink_basic results: parsing output: 32/ for test: gem_flink_basic results: parsing output: 33/ for test: gem_huc_copy results: parsing output: 34/ for test: gem_linear_blits results: parsing output: 35/ for test: gem_mmap results: parsing output: 36/ for test: gem_mmap_gtt results: parsing output: 37/ for test: gem_render_linear_blits results: parsing output: 38/ for test: gem_render_tiled_blits results: parsing output: 39/ for test: gem_ringfill results: parsing output: 40/ for test: gem_softpin results: parsing output: 41/ for test: gem_softpin results: parsing output: 42/ for test: gem_softpin results: parsing output: 43/ for test: gem_sync results: parsing output: 44/ for test: gem_sync results: parsing output: 45/ for test: gem_tiled_blits results: parsing output: 46/ for test: gem_tiled_fence_blits results: parsing output: 47/ for test: gem_tiled_pread_basic results: parsing output: 48/ for test: gem_wait results: parsing output: 49/ for test: gem_wait results: parsing output: 50/ for test: i915_getparams_basic results: parsing output: 51/ for test: i915_getparams_basic results: parsing output: 52/ for test: i915_hangman results: parsing output: 53/ for test: i915_pciid results: parsing output: 54/ for test: kms_addfb_basic results: parsing output: 55/ for test: kms_addfb_basic results: parsing output: 56/ for test: kms_addfb_basic results: parsing output: 57/ for test: kms_addfb_basic results: parsing output: 58/ for test: kms_addfb_basic results: parsing output: 59/ for test: kms_addfb_basic results: parsing output: 60/ for test: kms_addfb_basic results: parsing output: 61/ for test: kms_addfb_basic results: parsing output: 62/ for test: kms_addfb_basic results: parsing output: 63/ for test: kms_addfb_basic results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_addfb_basic results: parsing output: 66/ for test: kms_addfb_basic results: parsing output: 67/ for test: kms_addfb_basic results: parsing output: 68/ for test: kms_addfb_basic results: parsing output: 69/ for test: kms_addfb_basic results: parsing output: 70/ for test: kms_addfb_basic results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: kms_addfb_basic results: parsing output: 73/ for test: kms_addfb_basic results: parsing output: 74/ for test: kms_addfb_basic results: parsing output: 75/ for test: kms_addfb_basic results: parsing output: 76/ for test: kms_addfb_basic results: parsing output: 77/ for test: kms_addfb_basic results: parsing output: 78/ for test: kms_addfb_basic results: parsing output: 79/ for test: kms_addfb_basic results: parsing output: 80/ for test: kms_addfb_basic results: parsing output: 81/ for test: kms_addfb_basic results: parsing output: 82/ for test: kms_addfb_basic results: parsing output: 83/ for test: kms_addfb_basic results: parsing output: 84/ for test: kms_addfb_basic results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_addfb_basic results: parsing output: 87/ for test: kms_addfb_basic results: parsing output: 88/ for test: kms_addfb_basic results: parsing output: 89/ for test: kms_addfb_basic results: parsing output: 90/ for test: kms_addfb_basic results: parsing output: 91/ for test: kms_addfb_basic results: parsing output: 92/ for test: kms_busy results: parsing output: 93/ for test: kms_prop_blob results: parsing output: 94/ for test: kms_cursor_legacy results: parsing output: 95/ for test: kms_cursor_legacy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_cursor_legacy results: parsing output: 98/ for test: kms_cursor_legacy results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: kms_cursor_legacy results: parsing output: 101/ for test: kms_cursor_legacy results: parsing output: 102/ for test: kms_dsc results: parsing output: 103/ for test: kms_flip results: parsing output: 104/ for test: kms_flip results: parsing output: 105/ for test: kms_flip results: parsing output: 106/ for test: kms_flip results: parsing output: 107/ for test: kms_force_connector_basic results: parsing output: 108/ for test: kms_force_connector_basic results: parsing output: 109/ for test: kms_force_connector_basic results: parsing output: 110/ for test: kms_force_connector_basic results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_hdmi_inject results: parsing output: 113/ for test: kms_pipe_crc_basic results: parsing output: 114/ for test: kms_pipe_crc_basic results: parsing output: 115/ for test: kms_pipe_crc_basic results: parsing output: 116/ for test: kms_pipe_crc_basic results: parsing output: 117/ for test: kms_pipe_crc_basic results: parsing output: 118/ for test: kms_pipe_crc_basic results: parsing output: 119/ for test: kms_pipe_crc_basic results: parsing output: 120/ for test: kms_pm_backlight results: parsing output: 121/ for test: kms_pm_rpm results: parsing output: 122/ for test: kms_pm_rpm results: parsing output: 123/ for test: kms_psr results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_psr results: parsing output: 127/ for test: kms_setmode results: parsing output: 128/ for test: i915_pm_rps results: parsing output: 129/ for test: prime_self_import results: parsing output: 130/ for test: prime_self_import results: parsing output: 131/ for test: prime_self_import results: parsing output: 132/ for test: prime_self_import results: parsing output: 133/ for test: prime_self_import results: parsing output: 134/ for test: prime_self_import results: parsing output: 135/ for test: prime_vgem results: parsing output: 136/ for test: prime_vgem results: parsing output: 137/ for test: prime_vgem results: parsing output: 138/ for test: prime_vgem results: parsing output: 139/ for test: prime_vgem results: parsing output: 140/ for test: prime_vgem results: parsing output: 141/ for test: vgem_basic results: parsing output: 142/ for test: vgem_basic results: parsing output: 143/ for test: vgem_basic results: parsing output: 144/ for test: vgem_basic results: parsing output: 145/ for test: vgem_basic results: parsing output: 146/ for test: vgem_basic results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: vgem_basic results: parsing output: 149/ for test: vgem_basic results: parsing output: 150/ for test: vgem_basic results: parsing output: 151/ for test: core_hotunplug results: parsing output: 152/ for test: vgem_basic results: parsing output: 153/ for test: i915_module_load results: parsing output: 154/ for test: gem_lmem_swapping results: parsing output: 155/ for test: gem_lmem_swapping results: parsing output: 156/ for test: gem_lmem_swapping results: parsing output: 157/ for test: gem_lmem_swapping results: parsing output: 158/ for test: i915_pm_rpm results: parsing output: 159/ for test: i915_selftest results: parsing output: 160/ for test: dmabuf Done.