[35.591223] Initializing watchdogs [35.591329] /dev/watchdog0 [35.615823] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:5926 Intel Kabylake (Gen9) Iris Plus Graphics 640 [35.621991] [001/162] (960s left) i915_module_load (load) [36.242692] Starting subtest: load [38.470108] Subtest load: SUCCESS (2.227s) [38.520381] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [38.522323] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [38.537169] [002/162] (957s left) core_auth (basic-auth) [38.668032] Starting subtest: basic-auth [38.669032] Subtest basic-auth: SUCCESS (0.001s) [38.713762] [003/162] (957s left) core_debugfs (read-all-entries) [38.771344] Starting subtest: read-all-entries [38.774234] Subtest read-all-entries: SUCCESS (0.003s) [38.821642] [004/162] (957s left) core_sysfs (read-all-entries) [38.879585] Starting subtest: read-all-entries [38.884922] Subtest read-all-entries: SUCCESS (0.006s) [38.934850] [005/162] (957s left) fbdev (eof) [39.003309] Subtest eof: SKIP (0.000s) [39.048263] [006/162] (957s left) fbdev (info) [39.116758] Subtest info: SKIP (0.000s) [39.162050] [007/162] (957s left) fbdev (nullptr) [39.229583] Subtest nullptr: SKIP (0.000s) [39.274668] [008/162] (957s left) fbdev (read) [39.341845] Subtest read: SKIP (0.000s) [39.387472] [009/162] (957s left) fbdev (write) [39.454967] Subtest write: SKIP (0.000s) [39.500964] [010/162] (957s left) gem_basic (bad-close) [39.558700] Starting subtest: bad-close [39.560477] Subtest bad-close: SUCCESS (0.000s) [39.606178] [011/162] (957s left) gem_basic (create-close) [39.690856] Starting subtest: create-close [39.692496] Subtest create-close: SUCCESS (0.000s) [39.755205] [012/162] (956s left) gem_basic (create-fd-close) [39.811486] Starting subtest: create-fd-close [39.813287] Subtest create-fd-close: SUCCESS (0.000s) [39.878371] [013/162] (956s left) gem_busy (busy@all-engines) [39.957624] Starting subtest: busy [39.959166] Starting dynamic subtest: all-engines [40.027691] Dynamic subtest all-engines: SUCCESS (0.070s) [40.028783] Subtest busy: SUCCESS (0.071s) [40.429300] [014/162] (956s left) gem_close_race (basic-process) [40.511421] Starting subtest: basic-process [40.572803] Subtest basic-process: SUCCESS (0.062s) [40.815068] [015/162] (956s left) gem_close_race (basic-threads) [40.898654] Starting subtest: basic-threads [42.122800] Subtest basic-threads: SUCCESS (1.225s) [42.317815] [016/162] (954s left) gem_ctx_create (basic) [42.395486] Starting subtest: basic [42.396585] Subtest basic: SUCCESS (0.000s) [42.579740] [017/162] (954s left) gem_ctx_create (basic-files) [42.653439] Starting subtest: basic-files [44.670813] Subtest basic-files: SUCCESS (2.017s) [44.920494] [018/162] (952s left) gem_ctx_exec (basic) [44.981035] Starting subtest: basic [44.985724] Subtest basic: SUCCESS (0.006s) [45.068751] [019/162] (952s left) gem_exec_basic (basic) [45.135137] Starting subtest: basic [45.136143] Starting dynamic subtest: rcs0-smem [45.139784] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [45.150183] Starting dynamic subtest: bcs0-smem [45.151766] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [45.161489] Starting dynamic subtest: vcs0-smem [45.162580] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [45.171633] Starting dynamic subtest: vcs1-smem [45.172810] Dynamic subtest vcs1-smem: SUCCESS (0.001s) [45.181952] Starting dynamic subtest: vecs0-smem [45.183079] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [45.184293] Subtest basic: SUCCESS (0.011s) [45.372924] [020/162] (951s left) gem_exec_create (basic) [45.444398] Starting subtest: basic [45.445365] Starting dynamic subtest: smem [47.531417] Dynamic subtest smem: SUCCESS (2.046s) [47.532958] Subtest basic: SUCCESS (2.046s) [47.665348] [021/162] (949s left) gem_exec_fence (basic-busy) [47.866666] Starting subtest: basic-busy [47.868800] Starting dynamic subtest: rcs0 [47.898611] Dynamic subtest rcs0: SUCCESS (0.032s) [47.914554] Starting dynamic subtest: bcs0 [47.928427] Dynamic subtest bcs0: SUCCESS (0.029s) [47.941474] Starting dynamic subtest: vcs0 [47.948417] Dynamic subtest vcs0: SUCCESS (0.020s) [47.959296] Starting dynamic subtest: vcs1 [47.971366] Dynamic subtest vcs1: SUCCESS (0.023s) [47.981341] Starting dynamic subtest: vecs0 [47.996422] Dynamic subtest vecs0: SUCCESS (0.025s) [47.997708] Subtest basic-busy: SUCCESS (0.130s) [48.701707] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [48.704585] [022/162] (948s left) gem_exec_fence (basic-wait) [48.927312] Starting subtest: basic-wait [48.928869] Starting dynamic subtest: rcs0 [48.951374] Dynamic subtest rcs0: SUCCESS (0.024s) [48.964464] Starting dynamic subtest: bcs0 [48.976477] Dynamic subtest bcs0: SUCCESS (0.024s) [48.988672] Starting dynamic subtest: vcs0 [48.998515] Dynamic subtest vcs0: SUCCESS (0.021s) [49.010751] Starting dynamic subtest: vcs1 [49.020313] Dynamic subtest vcs1: SUCCESS (0.021s) [49.030646] Starting dynamic subtest: vecs0 [49.045391] Dynamic subtest vecs0: SUCCESS (0.024s) [49.046501] Subtest basic-wait: SUCCESS (0.117s) [49.691246] [023/162] (947s left) gem_exec_fence (basic-await) [49.899451] Starting subtest: basic-await [49.901267] Starting dynamic subtest: rcs0 [50.015046] Dynamic subtest rcs0: SUCCESS (0.113s) [50.026785] Starting dynamic subtest: bcs0 [50.118183] Dynamic subtest bcs0: SUCCESS (0.102s) [50.130599] Starting dynamic subtest: vcs0 [50.228399] Dynamic subtest vcs0: SUCCESS (0.107s) [50.243888] Starting dynamic subtest: vcs1 [50.359341] Dynamic subtest vcs1: SUCCESS (0.128s) [50.374593] Starting dynamic subtest: vecs0 [50.477000] Dynamic subtest vecs0: SUCCESS (0.115s) [50.478626] Subtest basic-await: SUCCESS (0.569s) [51.165928] [024/162] (946s left) gem_exec_fence (nb-await) [51.380418] Starting subtest: nb-await [51.382375] Starting dynamic subtest: rcs0 [51.460732] Dynamic subtest rcs0: SUCCESS (0.078s) [51.480379] Starting dynamic subtest: bcs0 [51.534281] Dynamic subtest bcs0: SUCCESS (0.073s) [51.568148] Starting dynamic subtest: vcs0 [51.625557] Dynamic subtest vcs0: SUCCESS (0.087s) [51.654476] Starting dynamic subtest: vcs1 [51.712164] Dynamic subtest vcs1: SUCCESS (0.086s) [51.746757] Starting dynamic subtest: vecs0 [51.809429] Dynamic subtest vecs0: SUCCESS (0.092s) [51.811349] Subtest nb-await: SUCCESS (0.424s) [52.506261] [025/162] (945s left) gem_exec_gttfill (basic) [52.580970] Starting subtest: basic [57.636551] Subtest basic: SUCCESS (5.031s) [57.863686] [026/162] (939s left) gem_exec_parallel (engines) [57.986508] Starting subtest: engines [57.987517] Starting dynamic subtest: basic [60.600102] Dynamic subtest basic: SUCCESS (2.561s) [60.611273] Starting dynamic subtest: contexts [63.504136] Dynamic subtest contexts: SUCCESS (2.886s) [63.515714] Starting dynamic subtest: fds [67.537182] Dynamic subtest fds: SUCCESS (4.028s) [67.551856] Starting dynamic subtest: userptr [70.129776] Dynamic subtest userptr: SUCCESS (2.598s) [70.131748] Subtest engines: SUCCESS (12.076s) [70.295759] [027/162] (927s left) gem_exec_store (basic) [70.376650] Starting subtest: basic [70.433115] Subtest basic: SUCCESS (0.056s) [70.638964] [028/162] (927s left) gem_flink_basic (bad-flink) [70.698393] Starting subtest: bad-flink [70.699570] Subtest bad-flink: SUCCESS (0.000s) [70.753401] [029/162] (927s left) gem_flink_basic (bad-open) [70.810522] Starting subtest: bad-open [70.811700] Subtest bad-open: SUCCESS (0.000s) [70.885794] [030/162] (927s left) gem_flink_basic (basic) [71.164874] Starting subtest: basic [71.167296] Subtest basic: SUCCESS (0.000s) [71.261590] [031/162] (926s left) gem_flink_basic (double-flink) [71.318806] Starting subtest: double-flink [71.319845] Subtest double-flink: SUCCESS (0.000s) [71.392763] [032/162] (926s left) gem_flink_basic (flink-lifetime) [71.449291] Starting subtest: flink-lifetime [71.451911] Subtest flink-lifetime: SUCCESS (0.002s) [71.524949] [033/162] (926s left) gem_huc_copy (huc-copy) [71.593546] Starting subtest: huc-copy [71.595766] Subtest huc-copy: SKIP (0.000s) [71.688620] [034/162] (926s left) gem_linear_blits (basic) [71.867848] Starting subtest: basic [71.873738] Subtest basic: SUCCESS (0.006s) [71.975125] [035/162] (926s left) gem_mmap (basic) [72.189798] Starting subtest: basic [72.197311] Subtest basic: SUCCESS (0.001s) [72.284105] [036/162] (926s left) gem_mmap_gtt (basic) [72.341499] Starting subtest: basic [72.342439] Subtest basic: SUCCESS (0.001s) [72.398047] [037/162] (925s left) gem_render_linear_blits (basic) [72.464940] Starting subtest: basic [72.498259] Subtest basic: SUCCESS (0.033s) [72.571459] [038/162] (925s left) gem_render_tiled_blits (basic) [72.640780] Starting subtest: basic [72.685236] Subtest basic: SUCCESS (0.044s) [72.748835] [039/162] (925s left) gem_ringfill (basic-all) [73.057539] Starting subtest: basic-all [74.287188] Subtest basic-all: SUCCESS (1.175s) [74.345319] [040/162] (924s left) gem_softpin (allocator-basic) [74.416466] Starting subtest: allocator-basic [74.634797] Subtest allocator-basic: SUCCESS (0.161s) [74.687890] [041/162] (923s left) gem_softpin (allocator-basic-reserve) [74.759147] Starting subtest: allocator-basic-reserve [74.968136] Subtest allocator-basic-reserve: SUCCESS (0.154s) [75.027345] [042/162] (923s left) gem_softpin (safe-alignment) [75.099882] Starting subtest: safe-alignment [75.118590] Subtest safe-alignment: SUCCESS (0.019s) [75.206417] [043/162] (923s left) gem_sync (basic-all) [75.289646] Starting subtest: basic-all [77.709416] Subtest basic-all: SUCCESS (2.378s) [77.869202] [044/162] (920s left) gem_sync (basic-each) [77.950168] Starting subtest: basic-each [80.146877] Subtest basic-each: SUCCESS (2.196s) [80.395795] [045/162] (918s left) gem_tiled_blits (basic) [80.533191] Starting subtest: basic [80.550870] Subtest basic: SUCCESS (0.017s) [80.670317] [046/162] (918s left) gem_tiled_fence_blits (basic) [81.222789] Starting subtest: basic [81.234678] Subtest basic: SUCCESS (0.012s) [81.322986] [047/162] (917s left) gem_tiled_pread_basic (basic) [81.490963] Starting subtest: basic [81.697599] Subtest basic: SUCCESS (0.150s) [81.761880] [048/162] (917s left) gem_wait (busy@all-engines) [81.854807] Starting subtest: busy [81.856292] Starting dynamic subtest: all-engines [82.432079] Dynamic subtest all-engines: SUCCESS (0.529s) [82.434057] Subtest busy: SUCCESS (0.530s) [82.589580] [049/162] (916s left) gem_wait (wait@all-engines) [82.674550] Starting subtest: wait [82.675688] Starting dynamic subtest: all-engines [83.759529] Dynamic subtest all-engines: SUCCESS (1.084s) [83.762387] Subtest wait: SUCCESS (1.085s) [84.064989] [050/162] (915s left) i915_getparams_basic (basic-eu-total) [84.126598] Starting subtest: basic-eu-total [84.128747] Subtest basic-eu-total: SUCCESS (0.000s) [84.182119] [051/162] (915s left) i915_getparams_basic (basic-subslice-total) [84.239707] Starting subtest: basic-subslice-total [84.243384] Subtest basic-subslice-total: SUCCESS (0.000s) [84.295152] [052/162] (915s left) i915_hangman (error-state-basic) [84.383485] Starting subtest: error-state-basic [84.392988] Subtest error-state-basic: SUCCESS (0.009s) [84.540356] [053/162] (914s left) i915_pciid [84.792762] [054/162] (914s left) intel_hwmon (hwmon-read) [84.850335] Subtest hwmon-read: SKIP (0.000s) [84.906086] [055/162] (914s left) intel_hwmon (hwmon-write) [84.964239] Subtest hwmon-write: SKIP (0.000s) [85.020725] [056/162] (914s left) kms_addfb_basic (addfb25-4-tiled) [85.358196] Starting subtest: addfb25-4-tiled [85.359415] Subtest addfb25-4-tiled: SUCCESS (0.001s) [85.441546] [057/162] (914s left) kms_addfb_basic (addfb25-bad-modifier) [85.717613] Starting subtest: addfb25-bad-modifier [85.718757] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [85.804786] [058/162] (914s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [86.076979] Starting subtest: addfb25-framebuffer-vs-set-tiling [86.078236] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [86.175287] [059/162] (913s left) kms_addfb_basic (addfb25-modifier-no-flag) [86.450752] Starting subtest: addfb25-modifier-no-flag [86.451945] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [86.555364] [060/162] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy) [86.839648] Starting subtest: addfb25-x-tiled-legacy [86.842122] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [86.937810] [061/162] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [87.211986] Starting subtest: addfb25-x-tiled-mismatch-legacy [87.215768] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [87.305980] [062/162] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [87.574017] Starting subtest: addfb25-yf-tiled-legacy [87.575341] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [87.660647] [063/162] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy) [87.926438] Starting subtest: addfb25-y-tiled-legacy [87.927583] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [88.011585] [064/162] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [88.288322] Starting subtest: addfb25-y-tiled-small-legacy [88.289269] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [88.377033] [065/162] (911s left) kms_addfb_basic (bad-pitch-0) [88.480283] Starting subtest: bad-pitch-0 [88.481431] Subtest bad-pitch-0: SUCCESS (0.000s) [88.781622] [066/162] (911s left) kms_addfb_basic (bad-pitch-1024) [88.837867] Starting subtest: bad-pitch-1024 [88.838818] Subtest bad-pitch-1024: SUCCESS (0.000s) [89.158435] [067/162] (911s left) kms_addfb_basic (bad-pitch-128) [89.218226] Starting subtest: bad-pitch-128 [89.219100] Subtest bad-pitch-128: SUCCESS (0.000s) [89.524331] [068/162] (911s left) kms_addfb_basic (bad-pitch-256) [89.581996] Starting subtest: bad-pitch-256 [89.582979] Subtest bad-pitch-256: SUCCESS (0.000s) [89.886777] [069/162] (910s left) kms_addfb_basic (bad-pitch-32) [89.945108] Starting subtest: bad-pitch-32 [89.945984] Subtest bad-pitch-32: SUCCESS (0.000s) [90.240294] [070/162] (910s left) kms_addfb_basic (bad-pitch-63) [90.298704] Starting subtest: bad-pitch-63 [90.300243] Subtest bad-pitch-63: SUCCESS (0.000s) [90.602432] [071/162] (910s left) kms_addfb_basic (bad-pitch-65536) [90.662016] Starting subtest: bad-pitch-65536 [90.662952] Subtest bad-pitch-65536: SUCCESS (0.000s) [90.968680] [072/162] (909s left) kms_addfb_basic (bad-pitch-999) [91.026308] Starting subtest: bad-pitch-999 [91.027216] Subtest bad-pitch-999: SUCCESS (0.000s) [91.322013] [073/162] (909s left) kms_addfb_basic (basic) [91.380184] Starting subtest: basic [91.381103] Subtest basic: SUCCESS (0.000s) [91.694800] [074/162] (909s left) kms_addfb_basic (basic-x-tiled-legacy) [91.753264] Starting subtest: basic-x-tiled-legacy [91.754195] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [92.058759] [075/162] (908s left) kms_addfb_basic (basic-y-tiled-legacy) [92.115478] Starting subtest: basic-y-tiled-legacy [92.116486] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [92.414734] [076/162] (908s left) kms_addfb_basic (bo-too-small) [92.680446] Starting subtest: bo-too-small [92.681859] Subtest bo-too-small: SUCCESS (0.001s) [92.775747] [077/162] (908s left) kms_addfb_basic (bo-too-small-due-to-tiling) [93.054124] Starting subtest: bo-too-small-due-to-tiling [93.055397] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [93.133009] [078/162] (908s left) kms_addfb_basic (clobberred-modifier) [93.190142] Starting subtest: clobberred-modifier [93.191101] Subtest clobberred-modifier: SUCCESS (0.000s) [93.485031] [079/162] (907s left) kms_addfb_basic (framebuffer-vs-set-tiling) [93.542565] Starting subtest: framebuffer-vs-set-tiling [93.543518] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [93.850624] [080/162] (907s left) kms_addfb_basic (invalid-get-prop) [93.909433] Starting subtest: invalid-get-prop [93.910314] Subtest invalid-get-prop: SUCCESS (0.000s) [94.216873] [081/162] (907s left) kms_addfb_basic (invalid-get-prop-any) [94.275180] Starting subtest: invalid-get-prop-any [94.276074] Subtest invalid-get-prop-any: SUCCESS (0.000s) [94.584857] [082/162] (906s left) kms_addfb_basic (invalid-set-prop) [94.643757] Starting subtest: invalid-set-prop [94.644790] Subtest invalid-set-prop: SUCCESS (0.000s) [94.938835] [083/162] (906s left) kms_addfb_basic (invalid-set-prop-any) [94.997883] Starting subtest: invalid-set-prop-any [94.998894] Subtest invalid-set-prop-any: SUCCESS (0.000s) [95.299398] [084/162] (906s left) kms_addfb_basic (no-handle) [95.359483] Starting subtest: no-handle [95.360439] Subtest no-handle: SUCCESS (0.000s) [95.664427] [085/162] (906s left) kms_addfb_basic (size-max) [95.934063] Starting subtest: size-max [95.935258] Subtest size-max: SUCCESS (0.000s) [96.013130] [086/162] (905s left) kms_addfb_basic (small-bo) [96.279103] Starting subtest: small-bo [96.280440] Subtest small-bo: SUCCESS (0.000s) [96.363422] [087/162] (905s left) kms_addfb_basic (tile-pitch-mismatch) [96.422229] Starting subtest: tile-pitch-mismatch [96.423173] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [96.724630] [088/162] (905s left) kms_addfb_basic (too-high) [97.000063] Starting subtest: too-high [97.001305] Subtest too-high: SUCCESS (0.001s) [97.088345] [089/162] (904s left) kms_addfb_basic (too-wide) [97.351805] Starting subtest: too-wide [97.353019] Subtest too-wide: SUCCESS (0.000s) [97.451072] [090/162] (904s left) kms_addfb_basic (unused-handle) [97.508025] Starting subtest: unused-handle [97.509086] Subtest unused-handle: SUCCESS (0.000s) [97.806664] [091/162] (904s left) kms_addfb_basic (unused-modifier) [97.864467] Starting subtest: unused-modifier [97.865384] Subtest unused-modifier: SUCCESS (0.000s) [98.170303] [092/162] (903s left) kms_addfb_basic (unused-offsets) [98.226491] Starting subtest: unused-offsets [98.227528] Subtest unused-offsets: SUCCESS (0.000s) [98.526697] [093/162] (903s left) kms_addfb_basic (unused-pitches) [98.584575] Starting subtest: unused-pitches [98.585549] Subtest unused-pitches: SUCCESS (0.000s) [98.900744] [094/162] (903s left) kms_busy (basic) [99.175170] Subtest basic: SKIP (0.000s) [99.245759] [095/162] (903s left) kms_prop_blob (basic) [99.304273] Starting subtest: basic [99.305261] Subtest basic: SUCCESS (0.000s) [99.359422] [096/162] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [99.642079] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [99.698682] [097/162] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [99.978952] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [100.053705] [098/162] (902s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [100.331436] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [100.391792] [099/162] (902s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [100.674740] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [100.732620] [100/162] (901s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [101.008837] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [101.072417] [101/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [101.356285] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [101.413065] [102/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [101.694200] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [101.755290] [103/162] (901s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [102.029445] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [102.085206] [104/162] (900s left) kms_dsc (dsc-basic) [102.363567] Subtest dsc-basic: SKIP (0.000s) [102.435622] [105/162] (900s left) kms_flip (basic-flip-vs-dpms) [102.702319] Starting subtest: basic-flip-vs-dpms [102.705784] Subtest basic-flip-vs-dpms: SKIP (0.003s) [102.784320] [106/162] (900s left) kms_flip (basic-flip-vs-modeset) [103.059997] Starting subtest: basic-flip-vs-modeset [103.063886] Subtest basic-flip-vs-modeset: SKIP (0.003s) [103.151400] [107/162] (899s left) kms_flip (basic-flip-vs-wf_vblank) [103.416466] Starting subtest: basic-flip-vs-wf_vblank [103.418776] Subtest basic-flip-vs-wf_vblank: SKIP (0.002s) [103.501200] [108/162] (899s left) kms_flip (basic-plain-flip) [103.769630] Starting subtest: basic-plain-flip [103.772803] Subtest basic-plain-flip: SKIP (0.003s) [103.849239] [109/162] (899s left) kms_force_connector_basic (force-connector-state) [104.242371] Starting subtest: force-connector-state [105.024786] Subtest force-connector-state: SUCCESS (0.783s) [105.605983] [110/162] (897s left) kms_force_connector_basic (force-edid) [105.995448] Starting subtest: force-edid [106.649029] Subtest force-edid: SUCCESS (0.654s) [107.145708] [111/162] (896s left) kms_force_connector_basic (force-load-detect) [107.533992] Starting subtest: force-load-detect [107.536677] Subtest force-load-detect: SKIP (0.000s) [107.931013] [112/162] (895s left) kms_force_connector_basic (prune-stale-modes) [108.324350] Starting subtest: prune-stale-modes [109.056782] Subtest prune-stale-modes: SUCCESS (0.733s) [109.568949] [113/162] (893s left) kms_frontbuffer_tracking (basic) [109.841801] Subtest basic: SKIP (0.000s) [109.915724] [114/162] (893s left) kms_hdmi_inject (inject-audio) [109.976564] Starting subtest: inject-audio [110.600249] Subtest inject-audio: SUCCESS (0.622s) [110.862586] [115/162] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [111.130796] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [111.198440] [116/162] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [111.465837] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [111.537323] [117/162] (892s left) kms_pipe_crc_basic (hang-read-crc) [111.818756] Subtest hang-read-crc: SKIP (0.000s) [111.894281] [118/162] (891s left) kms_pipe_crc_basic (nonblocking-crc) [112.164668] Subtest nonblocking-crc: SKIP (0.000s) [112.236262] [119/162] (891s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [112.510186] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [112.577569] [120/162] (891s left) kms_pipe_crc_basic (read-crc) [112.846496] Subtest read-crc: SKIP (0.000s) [112.915802] [121/162] (891s left) kms_pipe_crc_basic (read-crc-frame-sequence) [113.186281] Subtest read-crc-frame-sequence: SKIP (0.000s) [113.262026] [122/162] (890s left) kms_pm_backlight (basic-brightness) [113.534994] Subtest basic-brightness: SKIP (0.000s) [113.604779] [123/162] (890s left) kms_pm_rpm (basic-pci-d3-state) [115.276313] Starting subtest: basic-pci-d3-state [115.594850] Subtest basic-pci-d3-state: SUCCESS (0.319s) [115.866372] [124/162] (888s left) kms_pm_rpm (basic-rte) [116.102597] Starting subtest: basic-rte [118.012775] Subtest basic-rte: SUCCESS (1.908s) [118.488146] [125/162] (885s left) kms_psr (psr-primary-page-flip) [119.061048] Subtest psr-primary-page-flip: SKIP (0.000s) [119.133476] [126/162] (885s left) kms_psr (psr-cursor-plane-move) [119.403444] Subtest psr-cursor-plane-move: SKIP (0.000s) [119.477712] [127/162] (884s left) kms_psr (psr-sprite-plane-onoff) [119.745264] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [119.809420] [128/162] (884s left) kms_psr (psr-primary-mmap-gtt) [120.082336] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [120.158633] [129/162] (884s left) kms_setmode (basic-clone-single-crtc) [120.217313] Starting subtest: basic-clone-single-crtc [120.220101] Subtest basic-clone-single-crtc: SKIP (0.000s) [120.279396] [130/162] (884s left) i915_pm_rps (basic-api) [120.349847] Starting subtest: basic-api [120.353930] Subtest basic-api: SUCCESS (0.005s) [120.435721] [131/162] (884s left) prime_self_import (basic-llseek-bad) [120.492911] Starting subtest: basic-llseek-bad [120.494885] Subtest basic-llseek-bad: SUCCESS (0.003s) [120.569292] [132/162] (884s left) prime_self_import (basic-llseek-size) [120.626379] Starting subtest: basic-llseek-size [120.629438] Subtest basic-llseek-size: SUCCESS (0.004s) [120.719935] [133/162] (884s left) prime_self_import (basic-with_fd_dup) [120.775632] Starting subtest: basic-with_fd_dup [120.778628] Subtest basic-with_fd_dup: SUCCESS (0.004s) [120.858410] [134/162] (884s left) prime_self_import (basic-with_one_bo) [120.913243] Starting subtest: basic-with_one_bo [120.916883] Subtest basic-with_one_bo: SUCCESS (0.005s) [120.986218] [135/162] (883s left) prime_self_import (basic-with_one_bo_two_files) [121.043077] Starting subtest: basic-with_one_bo_two_files [121.044957] Subtest basic-with_one_bo_two_files: SUCCESS (0.004s) [121.125777] [136/162] (883s left) prime_self_import (basic-with_two_bos) [121.179475] Starting subtest: basic-with_two_bos [121.184582] Subtest basic-with_two_bos: SUCCESS (0.005s) [121.263268] [137/162] (883s left) prime_vgem (basic-fence-flip) [121.332083] Starting subtest: basic-fence-flip [121.544786] Subtest basic-fence-flip: SKIP (0.212s) [121.619129] [138/162] (883s left) prime_vgem (basic-fence-mmap) [121.686737] Starting subtest: basic-fence-mmap [121.721269] Subtest basic-fence-mmap: SUCCESS (0.035s) [121.803671] [139/162] (883s left) prime_vgem (basic-fence-read) [121.875901] Starting subtest: basic-fence-read [121.949687] Subtest basic-fence-read: SUCCESS (0.074s) [122.018568] [140/162] (883s left) prime_vgem (basic-gtt) [122.099304] Starting subtest: basic-gtt [122.116471] Subtest basic-gtt: SUCCESS (0.017s) [122.201147] [141/162] (883s left) prime_vgem (basic-read) [122.269498] Starting subtest: basic-read [122.305863] Subtest basic-read: SUCCESS (0.036s) [122.378483] [142/162] (882s left) prime_vgem (basic-write) [122.447141] Starting subtest: basic-write [122.481969] Subtest basic-write: SUCCESS (0.035s) [122.547757] [143/162] (882s left) vgem_basic (setversion) [122.607913] Starting subtest: setversion [122.609670] Subtest setversion: SUCCESS (0.000s) [122.669752] [144/162] (882s left) vgem_basic (create) [122.731174] Starting subtest: create [122.732133] Subtest create: SUCCESS (0.000s) [122.786778] [145/162] (882s left) vgem_basic (debugfs) [122.846057] Starting subtest: debugfs [122.847027] Subtest debugfs: SUCCESS (0.000s) [122.907016] [146/162] (882s left) vgem_basic (dmabuf-export) [122.967130] Starting subtest: dmabuf-export [122.968992] Subtest dmabuf-export: SUCCESS (0.003s) [123.044976] [147/162] (882s left) vgem_basic (dmabuf-fence) [123.105255] Starting subtest: dmabuf-fence [123.106215] Subtest dmabuf-fence: SUCCESS (0.001s) [123.164228] [148/162] (882s left) vgem_basic (dmabuf-fence-before) [123.223271] Starting subtest: dmabuf-fence-before [123.224207] Subtest dmabuf-fence-before: SUCCESS (0.001s) [123.285853] [149/162] (882s left) vgem_basic (dmabuf-mmap) [123.345528] Starting subtest: dmabuf-mmap [123.356044] Subtest dmabuf-mmap: SUCCESS (0.012s) [123.417355] [150/162] (882s left) vgem_basic (mmap) [123.478275] Starting subtest: mmap [123.486314] Subtest mmap: SUCCESS (0.009s) [123.545368] [151/162] (882s left) vgem_basic (second-client) [123.605204] Starting subtest: second-client [123.609398] Subtest second-client: SUCCESS (0.004s) [123.668355] [152/162] (882s left) vgem_basic (sysfs) [123.727054] Starting subtest: sysfs [123.728013] Subtest sysfs: SUCCESS (0.001s) [123.787680] [153/162] (882s left) core_hotunplug (unbind-rebind) [123.895201] Starting subtest: unbind-rebind [127.969881] Subtest unbind-rebind: SUCCESS (4.069s) [128.023809] [154/162] (878s left) vgem_basic (unload) [128.091712] Starting subtest: unload [157.071149] Subtest unload: SUCCESS (28.923s) [157.125236] [155/162] (848s left) i915_module_load (reload) [157.197056] Starting subtest: reload [160.594274] Subtest reload: SUCCESS (3.372s) [160.675401] [156/162] (845s left) gem_lmem_swapping (basic) [160.971117] Subtest basic: SKIP (0.000s) [161.061825] [157/162] (845s left) gem_lmem_swapping (parallel-random-engines) [161.125169] Subtest parallel-random-engines: SKIP (0.000s) [161.182206] [158/162] (845s left) gem_lmem_swapping (random-engines) [161.246284] Subtest random-engines: SKIP (0.000s) [161.301228] [159/162] (845s left) gem_lmem_swapping (verify-random) [161.364989] Subtest verify-random: SKIP (0.000s) [161.418904] [160/162] (845s left) i915_pm_rpm (module-reload) [164.317030] Starting subtest: module-reload [178.611569] Subtest module-reload: SUCCESS (14.244s) [178.678882] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [178.680380] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [178.683186] [161/162] (827s left) i915_selftest (live) [178.758473] Starting subtest: live [178.759764] Starting dynamic subtest: sanitycheck [181.316640] Dynamic subtest sanitycheck: SUCCESS (2.503s) [181.327223] Starting dynamic subtest: uncore [183.786779] Dynamic subtest uncore: SUCCESS (2.469s) [183.800743] Starting dynamic subtest: workarounds [186.607557] Dynamic subtest workarounds: SUCCESS (2.820s) [186.621409] Starting dynamic subtest: gt_engines [189.632797] Dynamic subtest gt_engines: SUCCESS (3.024s) [189.646601] Starting dynamic subtest: gt_timelines [204.172704] Dynamic subtest gt_timelines: SUCCESS (14.539s) [204.186584] Starting dynamic subtest: gt_contexts [206.832788] Dynamic subtest gt_contexts: SUCCESS (2.659s) [206.843470] Starting dynamic subtest: gt_lrc [212.458621] Dynamic subtest gt_lrc: SUCCESS (5.625s) [212.469294] Starting dynamic subtest: gt_mocs [215.012640] Dynamic subtest gt_mocs: SUCCESS (2.553s) [215.023363] Starting dynamic subtest: gt_pm [226.135812] Dynamic subtest gt_pm: SUCCESS (11.122s) [226.146591] Starting dynamic subtest: gt_heartbeat [228.633645] Dynamic subtest gt_heartbeat: SUCCESS (2.497s) [228.647578] Starting dynamic subtest: gt_tlb [232.796438] Dynamic subtest gt_tlb: SUCCESS (4.162s) [232.810366] Starting dynamic subtest: requests [242.747800] Dynamic subtest requests: SUCCESS (9.950s) [242.758642] Starting dynamic subtest: migrate [248.146651] Dynamic subtest migrate: SUCCESS (5.388s) [248.159542] Starting dynamic subtest: active [250.660646] Dynamic subtest active: SUCCESS (2.522s) [250.671327] Starting dynamic subtest: objects [254.040543] Dynamic subtest objects: SUCCESS (3.379s) [254.051236] Starting dynamic subtest: mman [260.081082] Dynamic subtest mman: SUCCESS (6.039s) [260.095080] Starting dynamic subtest: dmabuf [262.588429] Dynamic subtest dmabuf: SUCCESS (2.505s) [262.599321] Starting dynamic subtest: vma [265.070548] Dynamic subtest vma: SUCCESS (2.481s) [265.081298] Starting dynamic subtest: coherency [269.756940] Dynamic subtest coherency: SUCCESS (4.684s) [269.767646] Starting dynamic subtest: gtt [279.486645] Dynamic subtest gtt: SUCCESS (9.728s) [279.497436] Starting dynamic subtest: gem [282.490373] Dynamic subtest gem: SUCCESS (3.002s) [282.504414] Starting dynamic subtest: evict [287.280253] Dynamic subtest evict: SUCCESS (4.788s) [287.290947] Starting dynamic subtest: hugepages [296.212816] Dynamic subtest hugepages: SUCCESS (8.930s) [296.223514] Starting dynamic subtest: gem_contexts [315.797972] Dynamic subtest gem_contexts: SUCCESS (19.583s) [315.808896] Starting dynamic subtest: client [318.321125] Dynamic subtest client: SUCCESS (2.521s) [318.332061] Starting dynamic subtest: gem_migrate [320.796996] Dynamic subtest gem_migrate: SUCCESS (2.474s) [320.807849] Starting dynamic subtest: reset [323.708428] Dynamic subtest reset: SUCCESS (2.909s) [323.722708] Starting dynamic subtest: memory_region [326.173014] Dynamic subtest memory_region: SUCCESS (2.463s) [326.183756] Starting dynamic subtest: hangcheck [357.374606] Dynamic subtest hangcheck: SUCCESS (31.198s) [357.385375] Starting dynamic subtest: execlists [372.762059] Dynamic subtest execlists: SUCCESS (15.386s) [372.772882] Starting dynamic subtest: ring_submission [375.208012] Dynamic subtest ring_submission: SUCCESS (2.444s) [375.218794] Starting dynamic subtest: perf [377.711353] Dynamic subtest perf: SUCCESS (2.501s) [377.722164] Starting dynamic subtest: slpc [380.158941] Dynamic subtest slpc: SUCCESS (2.445s) [380.169766] Starting dynamic subtest: guc [382.627708] Dynamic subtest guc: SUCCESS (2.463s) [382.641076] Starting dynamic subtest: guc_multi_lrc [385.086846] Dynamic subtest guc_multi_lrc: SUCCESS (2.461s) [385.097707] Starting dynamic subtest: guc_hang [387.556516] Dynamic subtest guc_hang: SUCCESS (2.468s) [387.570632] Starting dynamic subtest: late_gt_pm [390.076790] Dynamic subtest late_gt_pm: SUCCESS (2.518s) [390.079179] Subtest live: SUCCESS (211.259s) [390.143447] [162/162] (616s left) dmabuf (all-tests) [390.216024] Starting subtest: all-tests [390.217478] Starting dynamic subtest: sanitycheck [390.285087] Dynamic subtest sanitycheck: SUCCESS (0.068s) [390.319651] Starting dynamic subtest: dma_fence [390.463648] Dynamic subtest dma_fence: SUCCESS (0.174s) [390.478653] Starting dynamic subtest: dma_fence_chain [390.481056] Dynamic subtest dma_fence_chain: SKIP (0.000s) [390.491804] Starting dynamic subtest: dma_fence_unwrap [390.534451] Dynamic subtest dma_fence_unwrap: SUCCESS (0.065s) [390.553997] Starting dynamic subtest: dma_resv [390.600090] Dynamic subtest dma_resv: SUCCESS (0.063s) [390.605826] Subtest all-tests: SUCCESS (0.386s) [390.687202] 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.