[52.041533] Initializing watchdogs [52.041620] /dev/watchdog0 [52.055808] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:591d Intel Kabylake (Gen9) HD Graphics P630 [52.063799] [001/162] (960s left) i915_module_load (load) [52.499942] Starting subtest: load [54.573664] Subtest load: SUCCESS (2.068s) [54.605352] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [54.607077] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true [54.611780] [002/162] (957s left) core_auth (basic-auth) [54.672771] Starting subtest: basic-auth [54.675996] Subtest basic-auth: SUCCESS (0.001s) [54.717760] [003/162] (957s left) core_debugfs (read-all-entries) [54.766337] Starting subtest: read-all-entries [54.769557] Subtest read-all-entries: SUCCESS (0.002s) [54.817156] [004/162] (957s left) core_sysfs (read-all-entries) [54.865639] Starting subtest: read-all-entries [54.869039] Subtest read-all-entries: SUCCESS (0.003s) [54.906870] [005/162] (957s left) fbdev (eof) [54.960985] Subtest eof: SKIP (0.000s) [54.998939] [006/162] (957s left) fbdev (info) [55.049814] Subtest info: SKIP (0.000s) [55.089599] [007/162] (957s left) fbdev (nullptr) [55.140648] Subtest nullptr: SKIP (0.000s) [55.178339] [008/162] (957s left) fbdev (read) [55.231147] Subtest read: SKIP (0.000s) [55.268206] [009/162] (957s left) fbdev (write) [55.321405] Subtest write: SKIP (0.000s) [55.358078] [010/162] (957s left) gem_basic (bad-close) [55.405795] Starting subtest: bad-close [55.412052] Subtest bad-close: SUCCESS (0.000s) [55.449478] [011/162] (957s left) gem_basic (create-close) [55.494548] Starting subtest: create-close [55.500710] Subtest create-close: SUCCESS (0.000s) [55.542844] [012/162] (957s left) gem_basic (create-fd-close) [55.588248] Starting subtest: create-fd-close [55.594541] Subtest create-fd-close: SUCCESS (0.000s) [55.643516] [013/162] (957s left) gem_busy (busy@all-engines) [55.704455] Starting subtest: busy [55.707549] Starting dynamic subtest: all-engines [55.727707] Dynamic subtest all-engines: SUCCESS (0.026s) [55.731146] Subtest busy: SUCCESS (0.026s) [56.046084] [014/162] (957s left) gem_close_race (basic-process) [56.104541] Starting subtest: basic-process [56.162909] Subtest basic-process: SUCCESS (0.058s) [56.314745] [015/162] (956s left) gem_close_race (basic-threads) [56.376469] Starting subtest: basic-threads [57.582680] Subtest basic-threads: SUCCESS (1.207s) [57.733997] [016/162] (955s left) gem_ctx_create (basic) [57.791612] Starting subtest: basic [57.794855] Subtest basic: SUCCESS (0.000s) [57.941214] [017/162] (955s left) gem_ctx_create (basic-files) [57.995124] Starting subtest: basic-files [60.007396] Subtest basic-files: SUCCESS (2.008s) [60.204419] [018/162] (953s left) gem_ctx_exec (basic) [60.267628] Starting subtest: basic [60.270748] Subtest basic: SUCCESS (0.003s) [60.323729] [019/162] (952s left) gem_exec_basic (basic) [60.376764] Starting subtest: basic [60.379953] Starting dynamic subtest: rcs0-smem [60.383390] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [60.393459] Starting dynamic subtest: bcs0-smem [60.396884] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [60.406867] Starting dynamic subtest: vcs0-smem [60.410303] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [60.419927] Starting dynamic subtest: vecs0-smem [60.423341] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [60.426798] Subtest basic: SUCCESS (0.005s) [60.574221] [020/162] (952s left) gem_exec_create (basic) [60.632166] Starting subtest: basic [60.635568] Starting dynamic subtest: smem [62.668516] Dynamic subtest smem: SUCCESS (2.037s) [62.671644] Subtest basic: SUCCESS (2.037s) [62.814878] [021/162] (950s left) gem_exec_fence (basic-busy) [62.982116] Starting subtest: basic-busy [62.985107] Starting dynamic subtest: rcs0 [63.017363] Dynamic subtest rcs0: SUCCESS (0.035s) [63.033917] Starting dynamic subtest: bcs0 [63.050130] Dynamic subtest bcs0: SUCCESS (0.033s) [63.061371] Starting dynamic subtest: vcs0 [63.078064] Dynamic subtest vcs0: SUCCESS (0.028s) [63.087765] Starting dynamic subtest: vecs0 [63.109350] Dynamic subtest vecs0: SUCCESS (0.031s) [63.112694] Subtest basic-busy: SUCCESS (0.127s) [63.639795] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true [63.643907] [022/162] (949s left) gem_exec_fence (basic-wait) [63.815653] Starting subtest: basic-wait [63.818679] Starting dynamic subtest: rcs0 [63.847581] Dynamic subtest rcs0: SUCCESS (0.031s) [63.868143] Starting dynamic subtest: bcs0 [63.875272] Dynamic subtest bcs0: SUCCESS (0.028s) [63.885476] Starting dynamic subtest: vcs0 [63.911587] Dynamic subtest vcs0: SUCCESS (0.035s) [63.924080] Starting dynamic subtest: vecs0 [63.943146] Dynamic subtest vecs0: SUCCESS (0.031s) [63.946430] Subtest basic-wait: SUCCESS (0.128s) [64.429804] [023/162] (949s left) gem_exec_fence (basic-await) [64.604525] Starting subtest: basic-await [64.607996] Starting dynamic subtest: rcs0 [64.682467] Dynamic subtest rcs0: SUCCESS (0.079s) [64.699420] Starting dynamic subtest: bcs0 [64.768443] Dynamic subtest bcs0: SUCCESS (0.085s) [64.787454] Starting dynamic subtest: vcs0 [64.857702] Dynamic subtest vcs0: SUCCESS (0.089s) [64.872126] Starting dynamic subtest: vecs0 [64.943350] Dynamic subtest vecs0: SUCCESS (0.084s) [64.946900] Subtest basic-await: SUCCESS (0.340s) [65.446369] [024/162] (948s left) gem_exec_fence (nb-await) [65.614545] Starting subtest: nb-await [65.618844] Starting dynamic subtest: rcs0 [65.675158] Dynamic subtest rcs0: SUCCESS (0.061s) [65.688765] Starting dynamic subtest: bcs0 [65.737290] Dynamic subtest bcs0: SUCCESS (0.060s) [65.757249] Starting dynamic subtest: vcs0 [65.803181] Dynamic subtest vcs0: SUCCESS (0.066s) [65.823651] Starting dynamic subtest: vecs0 [65.869062] Dynamic subtest vecs0: SUCCESS (0.065s) [65.872529] Subtest nb-await: SUCCESS (0.256s) [66.361921] [025/162] (947s left) gem_exec_gttfill (basic) [66.420821] Starting subtest: basic [70.160509] Subtest basic: SUCCESS (3.738s) [70.321071] [026/162] (943s left) gem_exec_parallel (engines) [70.450516] Starting subtest: engines [70.453533] Starting dynamic subtest: basic [72.191449] Dynamic subtest basic: SUCCESS (1.740s) [72.202876] Starting dynamic subtest: contexts [75.061900] Dynamic subtest contexts: SUCCESS (2.869s) [75.074994] Starting dynamic subtest: fds [77.832174] Dynamic subtest fds: SUCCESS (2.769s) [77.843154] Starting dynamic subtest: userptr [79.873606] Dynamic subtest userptr: SUCCESS (2.041s) [79.876856] Subtest engines: SUCCESS (9.422s) [80.030270] [027/162] (933s left) gem_exec_store (basic) [80.099137] Starting subtest: basic [80.154675] Subtest basic: SUCCESS (0.061s) [80.306395] [028/162] (933s left) gem_flink_basic (bad-flink) [80.355467] Starting subtest: bad-flink [80.358708] Subtest bad-flink: SUCCESS (0.000s) [80.400787] [029/162] (933s left) gem_flink_basic (bad-open) [80.448389] Starting subtest: bad-open [80.451710] Subtest bad-open: SUCCESS (0.000s) [80.494521] [030/162] (933s left) gem_flink_basic (basic) [80.538834] Starting subtest: basic [80.541908] Subtest basic: SUCCESS (0.000s) [80.599268] [031/162] (933s left) gem_flink_basic (double-flink) [80.646112] Starting subtest: double-flink [80.649106] Subtest double-flink: SUCCESS (0.000s) [80.702805] [032/162] (933s left) gem_flink_basic (flink-lifetime) [80.747250] Starting subtest: flink-lifetime [80.750419] Subtest flink-lifetime: SUCCESS (0.001s) [80.805976] [033/162] (933s left) gem_huc_copy (huc-copy) [80.859151] Starting subtest: huc-copy [80.865623] Subtest huc-copy: SKIP (0.000s) [80.931480] [034/162] (933s left) gem_linear_blits (basic) [81.053483] Starting subtest: basic [81.063048] Subtest basic: SUCCESS (0.010s) [81.158995] [035/162] (932s left) gem_mmap (basic) [81.287121] Starting subtest: basic [81.301827] Subtest basic: SUCCESS (0.000s) [81.343867] [036/162] (932s left) gem_mmap_gtt (basic) [81.392906] Starting subtest: basic [81.395906] Subtest basic: SUCCESS (0.001s) [81.440159] [037/162] (932s left) gem_render_linear_blits (basic) [81.491733] Starting subtest: basic [81.520430] Subtest basic: SUCCESS (0.030s) [81.577235] [038/162] (932s left) gem_render_tiled_blits (basic) [81.635088] Starting subtest: basic [81.661477] Subtest basic: SUCCESS (0.030s) [81.718092] [039/162] (932s left) gem_ringfill (basic-all) [81.944151] Starting subtest: basic-all [83.082997] Subtest basic-all: SUCCESS (1.134s) [83.156765] [040/162] (931s left) gem_softpin (allocator-basic) [83.208747] Starting subtest: allocator-basic [83.309455] Subtest allocator-basic: SUCCESS (0.103s) [83.394315] [041/162] (930s left) gem_softpin (allocator-basic-reserve) [83.446693] Starting subtest: allocator-basic-reserve [83.539739] Subtest allocator-basic-reserve: SUCCESS (0.095s) [83.625013] [042/162] (930s left) gem_softpin (safe-alignment) [83.690815] Starting subtest: safe-alignment [83.700079] Subtest safe-alignment: SUCCESS (0.011s) [83.773711] [043/162] (930s left) gem_sync (basic-all) [83.847163] Starting subtest: basic-all [86.112406] Subtest basic-all: SUCCESS (2.283s) [86.265662] [044/162] (928s left) gem_sync (basic-each) [86.343669] Starting subtest: basic-each [88.455483] Subtest basic-each: SUCCESS (2.130s) [88.612965] [045/162] (925s left) gem_tiled_blits (basic) [88.723740] Starting subtest: basic [88.731258] Subtest basic: SUCCESS (0.016s) [88.822447] [046/162] (925s left) gem_tiled_fence_blits (basic) [89.000386] Starting subtest: basic [89.008871] Subtest basic: SUCCESS (0.007s) [89.115468] [047/162] (925s left) gem_tiled_pread_basic (basic) [89.237876] Starting subtest: basic [89.357728] Subtest basic: SUCCESS (0.126s) [89.424863] [048/162] (925s left) gem_wait (busy@all-engines) [89.485580] Starting subtest: busy [89.488954] Starting dynamic subtest: all-engines [90.011219] Dynamic subtest all-engines: SUCCESS (0.524s) [90.014442] Subtest busy: SUCCESS (0.524s) [90.170445] [049/162] (924s left) gem_wait (wait@all-engines) [90.229562] Starting subtest: wait [90.232673] Starting dynamic subtest: all-engines [91.257333] Dynamic subtest all-engines: SUCCESS (1.024s) [91.260658] Subtest wait: SUCCESS (1.024s) [91.414995] [050/162] (923s left) i915_getparams_basic (basic-eu-total) [91.464587] Starting subtest: basic-eu-total [91.470652] Subtest basic-eu-total: SUCCESS (0.000s) [91.512702] [051/162] (923s left) i915_getparams_basic (basic-subslice-total) [91.561034] Starting subtest: basic-subslice-total [91.567190] Subtest basic-subslice-total: SUCCESS (0.000s) [91.608968] [052/162] (923s left) i915_hangman (error-state-basic) [91.664305] Starting subtest: error-state-basic [91.672141] Subtest error-state-basic: SUCCESS (0.005s) [91.723830] [053/162] (923s left) i915_pciid [91.818421] [054/162] (923s left) intel_hwmon (hwmon-read) [91.873448] Subtest hwmon-read: SKIP (0.000s) [91.915341] [055/162] (923s left) intel_hwmon (hwmon-write) [91.966911] Subtest hwmon-write: SKIP (0.000s) [92.010105] [056/162] (922s left) kms_addfb_basic (addfb25-4-tiled) [92.103129] Starting subtest: addfb25-4-tiled [92.106261] Subtest addfb25-4-tiled: SUCCESS (0.000s) [92.169661] [057/162] (922s left) kms_addfb_basic (addfb25-bad-modifier) [92.249672] Starting subtest: addfb25-bad-modifier [92.252758] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [92.310474] [058/162] (922s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [92.390781] Starting subtest: addfb25-framebuffer-vs-set-tiling [92.393899] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [92.450729] [059/162] (922s left) kms_addfb_basic (addfb25-modifier-no-flag) [92.530649] Starting subtest: addfb25-modifier-no-flag [92.533847] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [92.592907] [060/162] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [92.673507] Starting subtest: addfb25-x-tiled-legacy [92.676634] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [92.737270] [061/162] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [92.814013] Starting subtest: addfb25-x-tiled-mismatch-legacy [92.817163] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [92.873972] [062/162] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [92.956170] Starting subtest: addfb25-yf-tiled-legacy [92.959385] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [93.009354] [063/162] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy) [93.087687] Starting subtest: addfb25-y-tiled-legacy [93.090969] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [93.150774] [064/162] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [93.229606] Starting subtest: addfb25-y-tiled-small-legacy [93.233039] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [93.290704] [065/162] (922s left) kms_addfb_basic (bad-pitch-0) [93.346042] Starting subtest: bad-pitch-0 [93.349194] Subtest bad-pitch-0: SUCCESS (0.000s) [93.426391] [066/162] (921s left) kms_addfb_basic (bad-pitch-1024) [93.478701] Starting subtest: bad-pitch-1024 [93.482120] Subtest bad-pitch-1024: SUCCESS (0.000s) [93.709636] [067/162] (921s left) kms_addfb_basic (bad-pitch-128) [94.103352] Starting subtest: bad-pitch-128 [94.167665] Subtest bad-pitch-128: SUCCESS (0.000s) [94.684751] [068/162] (921s left) kms_addfb_basic (bad-pitch-256) [95.072472] Starting subtest: bad-pitch-256 [95.076632] Subtest bad-pitch-256: SUCCESS (0.000s) [95.119999] [069/162] (921s left) kms_addfb_basic (bad-pitch-32) [95.172949] Starting subtest: bad-pitch-32 [95.178274] Subtest bad-pitch-32: SUCCESS (0.000s) [95.256580] [070/162] (920s left) kms_addfb_basic (bad-pitch-63) [95.308192] Starting subtest: bad-pitch-63 [95.311989] Subtest bad-pitch-63: SUCCESS (0.000s) [95.398278] [071/162] (920s left) kms_addfb_basic (bad-pitch-65536) [95.448978] Starting subtest: bad-pitch-65536 [95.453594] Subtest bad-pitch-65536: SUCCESS (0.000s) [95.537370] [072/162] (920s left) kms_addfb_basic (bad-pitch-999) [95.592930] Starting subtest: bad-pitch-999 [95.596157] Subtest bad-pitch-999: SUCCESS (0.000s) [95.676655] [073/162] (920s left) kms_addfb_basic (basic) [95.728808] Starting subtest: basic [95.732252] Subtest basic: SUCCESS (0.000s) [95.822195] [074/162] (920s left) kms_addfb_basic (basic-x-tiled-legacy) [95.876919] Starting subtest: basic-x-tiled-legacy [95.880218] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [95.962970] [075/162] (920s left) kms_addfb_basic (basic-y-tiled-legacy) [96.013234] Starting subtest: basic-y-tiled-legacy [96.016690] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [96.100504] [076/162] (920s left) kms_addfb_basic (bo-too-small) [96.178072] Starting subtest: bo-too-small [96.181180] Subtest bo-too-small: SUCCESS (0.000s) [96.243983] [077/162] (920s left) kms_addfb_basic (bo-too-small-due-to-tiling) [96.325129] Starting subtest: bo-too-small-due-to-tiling [96.328403] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [96.382080] [078/162] (920s left) kms_addfb_basic (clobberred-modifier) [96.434874] Starting subtest: clobberred-modifier [96.437810] Subtest clobberred-modifier: SUCCESS (0.000s) [96.522805] [079/162] (920s left) kms_addfb_basic (framebuffer-vs-set-tiling) [96.572862] Starting subtest: framebuffer-vs-set-tiling [96.576912] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [96.674898] [080/162] (920s left) kms_addfb_basic (invalid-get-prop) [96.723985] Starting subtest: invalid-get-prop [96.728050] Subtest invalid-get-prop: SUCCESS (0.000s) [96.802673] [081/162] (919s left) kms_addfb_basic (invalid-get-prop-any) [96.858132] Starting subtest: invalid-get-prop-any [96.861180] Subtest invalid-get-prop-any: SUCCESS (0.000s) [96.943346] [082/162] (919s left) kms_addfb_basic (invalid-set-prop) [96.993353] Starting subtest: invalid-set-prop [96.998737] Subtest invalid-set-prop: SUCCESS (0.000s) [97.082062] [083/162] (919s left) kms_addfb_basic (invalid-set-prop-any) [97.133064] Starting subtest: invalid-set-prop-any [97.136599] Subtest invalid-set-prop-any: SUCCESS (0.000s) [97.225055] [084/162] (919s left) kms_addfb_basic (no-handle) [97.277193] Starting subtest: no-handle [97.282368] Subtest no-handle: SUCCESS (0.000s) [97.367301] [085/162] (919s left) kms_addfb_basic (size-max) [97.446577] Starting subtest: size-max [97.449802] Subtest size-max: SUCCESS (0.000s) [97.514684] [086/162] (919s left) kms_addfb_basic (small-bo) [97.594521] Starting subtest: small-bo [97.597923] Subtest small-bo: SUCCESS (0.000s) [97.657367] [087/162] (919s left) kms_addfb_basic (tile-pitch-mismatch) [97.709883] Starting subtest: tile-pitch-mismatch [97.712958] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [97.797605] [088/162] (919s left) kms_addfb_basic (too-high) [97.877897] Starting subtest: too-high [97.881280] Subtest too-high: SUCCESS (0.001s) [97.938648] [089/162] (919s left) kms_addfb_basic (too-wide) [98.015145] Starting subtest: too-wide [98.018183] Subtest too-wide: SUCCESS (0.000s) [98.064741] [090/162] (919s left) kms_addfb_basic (unused-handle) [98.116141] Starting subtest: unused-handle [98.119255] Subtest unused-handle: SUCCESS (0.000s) [98.206846] [091/162] (918s left) kms_addfb_basic (unused-modifier) [98.260724] Starting subtest: unused-modifier [98.263678] Subtest unused-modifier: SUCCESS (0.000s) [98.345931] [092/162] (918s left) kms_addfb_basic (unused-offsets) [98.394560] Starting subtest: unused-offsets [98.398363] Subtest unused-offsets: SUCCESS (0.000s) [98.488475] [093/162] (918s left) kms_addfb_basic (unused-pitches) [98.538987] Starting subtest: unused-pitches [98.542255] Subtest unused-pitches: SUCCESS (0.000s) [98.627834] [094/162] (918s left) kms_busy (basic) [98.711439] Subtest basic: SKIP (0.000s) [98.753087] [095/162] (918s left) kms_prop_blob (basic) [98.803858] Starting subtest: basic [98.806881] Subtest basic: SUCCESS (0.000s) [98.849884] [096/162] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [98.951536] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [98.996088] [097/162] (918s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [99.093175] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [99.140998] [098/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [99.240346] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s) [99.286933] [099/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [99.384616] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s) [99.429116] [100/162] (918s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [99.530595] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s) [99.575704] [101/162] (918s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [99.674526] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s) [99.719809] [102/162] (917s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [99.820966] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s) [99.875716] [103/162] (917s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [99.981183] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s) [100.026610] [104/162] (917s left) kms_dsc (dsc-basic) [100.109077] Subtest dsc-basic: SKIP (0.000s) [100.151926] [105/162] (917s left) kms_flip (basic-flip-vs-dpms) [100.229727] Starting subtest: basic-flip-vs-dpms [100.237101] Subtest basic-flip-vs-dpms: SKIP (0.001s) [100.279008] [106/162] (917s left) kms_flip (basic-flip-vs-modeset) [100.360353] Starting subtest: basic-flip-vs-modeset [100.367539] Subtest basic-flip-vs-modeset: SKIP (0.001s) [100.423608] [107/162] (917s left) kms_flip (basic-flip-vs-wf_vblank) [100.501945] Starting subtest: basic-flip-vs-wf_vblank [100.507828] Subtest basic-flip-vs-wf_vblank: SKIP (0.001s) [100.571553] [108/162] (917s left) kms_flip (basic-plain-flip) [100.650635] Starting subtest: basic-plain-flip [100.656490] Subtest basic-plain-flip: SKIP (0.001s) [100.699633] [109/162] (917s left) kms_force_connector_basic (force-connector-state) [100.848548] Starting subtest: force-connector-state [100.929109] Subtest force-connector-state: SUCCESS (0.079s) [101.084302] [110/162] (916s left) kms_force_connector_basic (force-edid) [101.240656] Starting subtest: force-edid [101.410906] Subtest force-edid: SUCCESS (0.177s) [101.498047] [111/162] (916s left) kms_force_connector_basic (force-load-detect) [101.644624] Starting subtest: force-load-detect [101.650628] Subtest force-load-detect: SKIP (0.000s) [101.713391] [112/162] (916s left) kms_force_connector_basic (prune-stale-modes) [101.863823] Starting subtest: prune-stale-modes [102.033154] Subtest prune-stale-modes: SUCCESS (0.171s) [102.114193] [113/162] (916s left) kms_frontbuffer_tracking (basic) [102.201067] Subtest basic: SKIP (0.000s) [102.258220] [114/162] (915s left) kms_hdmi_inject (inject-audio) [102.310705] Starting subtest: inject-audio [102.316938] Subtest inject-audio: SKIP (0.000s) [102.365916] [115/162] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [102.449981] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s) [102.495975] [116/162] (915s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [102.581239] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s) [102.624815] [117/162] (915s left) kms_pipe_crc_basic (hang-read-crc) [102.710499] Subtest hang-read-crc: SKIP (0.000s) [102.752895] [118/162] (915s left) kms_pipe_crc_basic (nonblocking-crc) [102.833331] Subtest nonblocking-crc: SKIP (0.000s) [102.877557] [119/162] (915s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [102.955506] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s) [103.004040] [120/162] (915s left) kms_pipe_crc_basic (read-crc) [103.088120] Subtest read-crc: SKIP (0.000s) [103.130629] [121/162] (915s left) kms_pipe_crc_basic (read-crc-frame-sequence) [103.210488] Subtest read-crc-frame-sequence: SKIP (0.000s) [103.253064] [122/162] (915s left) kms_pm_backlight (basic-brightness) [103.330156] Subtest basic-brightness: SKIP (0.000s) [103.374980] [123/162] (915s left) kms_pm_rpm (basic-pci-d3-state) [114.756850] Starting subtest: basic-pci-d3-state [114.935119] Subtest basic-pci-d3-state: SUCCESS (0.182s) [114.989649] [124/162] (903s left) kms_pm_rpm (basic-rte) [115.040888] Starting subtest: basic-rte [126.564131] Subtest basic-rte: SUCCESS (11.526s) [126.874994] [125/162] (891s left) kms_psr (psr-primary-page-flip) [126.954472] Subtest psr-primary-page-flip: SKIP (0.000s) [126.997114] [126/162] (891s left) kms_psr (psr-cursor-plane-move) [127.074780] Subtest psr-cursor-plane-move: SKIP (0.000s) [127.120915] [127/162] (891s left) kms_psr (psr-sprite-plane-onoff) [127.201285] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [127.244351] [128/162] (891s left) kms_psr (psr-primary-mmap-gtt) [127.323643] Subtest psr-primary-mmap-gtt: SKIP (0.000s) [127.366997] [129/162] (891s left) kms_setmode (basic-clone-single-crtc) [127.417326] Starting subtest: basic-clone-single-crtc [127.426526] Subtest basic-clone-single-crtc: SKIP (0.000s) [127.475815] [130/162] (891s left) i915_pm_rps (basic-api) [127.531180] Starting subtest: basic-api [127.534183] Subtest basic-api: SUCCESS (0.003s) [127.598574] [131/162] (891s left) prime_self_import (basic-llseek-bad) [127.646142] Starting subtest: basic-llseek-bad [127.652541] Subtest basic-llseek-bad: SUCCESS (0.002s) [127.727028] [132/162] (891s left) prime_self_import (basic-llseek-size) [127.778193] Starting subtest: basic-llseek-size [127.784981] Subtest basic-llseek-size: SUCCESS (0.003s) [127.842153] [133/162] (891s left) prime_self_import (basic-with_fd_dup) [127.893410] Starting subtest: basic-with_fd_dup [127.899967] Subtest basic-with_fd_dup: SUCCESS (0.002s) [127.962229] [134/162] (891s left) prime_self_import (basic-with_one_bo) [128.007521] Starting subtest: basic-with_one_bo [128.013700] Subtest basic-with_one_bo: SUCCESS (0.004s) [128.064406] [135/162] (891s left) prime_self_import (basic-with_one_bo_two_files) [128.114169] Starting subtest: basic-with_one_bo_two_files [128.120376] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [128.179756] [136/162] (891s left) prime_self_import (basic-with_two_bos) [128.225477] Starting subtest: basic-with_two_bos [128.231808] Subtest basic-with_two_bos: SUCCESS (0.002s) [128.295830] [137/162] (890s left) prime_vgem (basic-fence-flip) [128.353442] Starting subtest: basic-fence-flip [128.407491] Subtest basic-fence-flip: SKIP (0.056s) [128.454258] [138/162] (890s left) prime_vgem (basic-fence-mmap) [128.511653] Starting subtest: basic-fence-mmap [128.531711] Subtest basic-fence-mmap: SUCCESS (0.023s) [128.606373] [139/162] (890s left) prime_vgem (basic-fence-read) [128.660143] Starting subtest: basic-fence-read [128.704631] Subtest basic-fence-read: SUCCESS (0.044s) [128.775842] [140/162] (890s left) prime_vgem (basic-gtt) [128.832660] Starting subtest: basic-gtt [128.839989] Subtest basic-gtt: SUCCESS (0.011s) [128.913388] [141/162] (890s left) prime_vgem (basic-read) [128.965566] Starting subtest: basic-read [128.986997] Subtest basic-read: SUCCESS (0.022s) [129.056647] [142/162] (890s left) prime_vgem (basic-write) [129.109138] Starting subtest: basic-write [129.127529] Subtest basic-write: SUCCESS (0.021s) [129.193933] [143/162] (890s left) vgem_basic (setversion) [129.244449] Starting subtest: setversion [129.250543] Subtest setversion: SUCCESS (0.000s) [129.297438] [144/162] (890s left) vgem_basic (create) [129.349147] Starting subtest: create [129.352139] Subtest create: SUCCESS (0.000s) [129.400497] [145/162] (890s left) vgem_basic (debugfs) [129.455538] Starting subtest: debugfs [129.458580] Subtest debugfs: SUCCESS (0.000s) [129.507774] [146/162] (890s left) vgem_basic (dmabuf-export) [129.557340] Starting subtest: dmabuf-export [129.563604] Subtest dmabuf-export: SUCCESS (0.002s) [129.631727] [147/162] (890s left) vgem_basic (dmabuf-fence) [129.681740] Starting subtest: dmabuf-fence [129.684931] Subtest dmabuf-fence: SUCCESS (0.001s) [129.733483] [148/162] (890s left) vgem_basic (dmabuf-fence-before) [129.782414] Starting subtest: dmabuf-fence-before [129.785501] Subtest dmabuf-fence-before: SUCCESS (0.000s) [129.835828] [149/162] (889s left) vgem_basic (dmabuf-mmap) [129.886677] Starting subtest: dmabuf-mmap [129.889625] Subtest dmabuf-mmap: SUCCESS (0.008s) [129.935635] [150/162] (889s left) vgem_basic (mmap) [129.992364] Starting subtest: mmap [129.995523] Subtest mmap: SUCCESS (0.006s) [130.045070] [151/162] (889s left) vgem_basic (second-client) [130.094434] Starting subtest: second-client [130.100552] Subtest second-client: SUCCESS (0.002s) [130.149612] [152/162] (889s left) vgem_basic (sysfs) [130.203390] Starting subtest: sysfs [130.206488] Subtest sysfs: SUCCESS (0.000s) [130.256811] [153/162] (889s left) core_hotunplug (unbind-rebind) [130.363627] Starting subtest: unbind-rebind [133.806297] Subtest unbind-rebind: SUCCESS (3.443s) [133.850467] [154/162] (886s left) vgem_basic (unload) [133.897041] Starting subtest: unload [162.804562] Subtest unload: SUCCESS (28.906s) [162.868906] [155/162] (857s left) i915_module_load (reload) [162.921135] Starting subtest: reload [165.416807] Subtest reload: SUCCESS (2.501s) [165.458820] [156/162] (854s left) gem_lmem_swapping (basic) [165.521774] Subtest basic: SKIP (0.000s) [165.562992] [157/162] (854s left) gem_lmem_swapping (parallel-random-engines) [165.615103] Subtest parallel-random-engines: SKIP (0.000s) [165.659488] [158/162] (854s left) gem_lmem_swapping (random-engines) [165.708120] Subtest random-engines: SKIP (0.000s) [165.750384] [159/162] (854s left) gem_lmem_swapping (verify-random) [165.801841] Subtest verify-random: SKIP (0.000s) [165.844725] [160/162] (854s left) i915_pm_rpm (module-reload) [177.253302] Starting subtest: module-reload [204.893955] Subtest module-reload: SUCCESS (27.640s) [204.925312] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [204.926304] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true [204.930594] [161/162] (815s left) i915_selftest (live) [204.980876] Starting subtest: live [204.984113] Starting dynamic subtest: sanitycheck [207.164871] Dynamic subtest sanitycheck: SUCCESS (2.177s) [207.177851] Starting dynamic subtest: uncore [209.290401] Dynamic subtest uncore: SUCCESS (2.129s) [209.306382] Starting dynamic subtest: workarounds [211.573973] Dynamic subtest workarounds: SUCCESS (2.285s) [211.584310] Starting dynamic subtest: gt_engines [214.090655] Dynamic subtest gt_engines: SUCCESS (2.516s) [214.101052] Starting dynamic subtest: gt_timelines [222.756817] Dynamic subtest gt_timelines: SUCCESS (8.665s) [222.767618] Starting dynamic subtest: gt_contexts [225.025020] Dynamic subtest gt_contexts: SUCCESS (2.259s) [225.039453] Starting dynamic subtest: gt_lrc [229.560756] Dynamic subtest gt_lrc: SUCCESS (4.543s) [229.575561] Starting dynamic subtest: gt_mocs [231.775207] Dynamic subtest gt_mocs: SUCCESS (2.204s) [231.785558] Starting dynamic subtest: gt_pm [238.174604] Dynamic subtest gt_pm: SUCCESS (6.408s) [238.185180] Starting dynamic subtest: gt_heartbeat [240.285124] Dynamic subtest gt_heartbeat: SUCCESS (2.108s) [240.299863] Starting dynamic subtest: gt_tlb [243.602552] Dynamic subtest gt_tlb: SUCCESS (3.318s) [243.613299] Starting dynamic subtest: requests [251.924013] Dynamic subtest requests: SUCCESS (8.320s) [251.938933] Starting dynamic subtest: migrate [257.052449] Dynamic subtest migrate: SUCCESS (5.128s) [257.063467] Starting dynamic subtest: active [259.156232] Dynamic subtest active: SUCCESS (2.096s) [259.169300] Starting dynamic subtest: objects [261.799680] Dynamic subtest objects: SUCCESS (2.649s) [261.810605] Starting dynamic subtest: mman [267.053864] Dynamic subtest mman: SUCCESS (5.253s) [267.064400] Starting dynamic subtest: dmabuf [269.275076] Dynamic subtest dmabuf: SUCCESS (2.216s) [269.285860] Starting dynamic subtest: vma [271.505572] Dynamic subtest vma: SUCCESS (2.234s) [271.517159] Starting dynamic subtest: coherency [274.458279] Dynamic subtest coherency: SUCCESS (2.949s) [274.474214] Starting dynamic subtest: gtt [283.989910] Dynamic subtest gtt: SUCCESS (9.533s) [284.000815] Starting dynamic subtest: gem [286.275353] Dynamic subtest gem: SUCCESS (2.278s) [286.286127] Starting dynamic subtest: evict [289.520794] Dynamic subtest evict: SUCCESS (3.251s) [289.531579] Starting dynamic subtest: hugepages [298.073367] Dynamic subtest hugepages: SUCCESS (8.550s) [298.086403] Starting dynamic subtest: gem_contexts [312.797602] Dynamic subtest gem_contexts: SUCCESS (14.725s) [312.813388] Starting dynamic subtest: client [314.948810] Dynamic subtest client: SUCCESS (2.150s) [314.959983] Starting dynamic subtest: gem_migrate [317.061926] Dynamic subtest gem_migrate: SUCCESS (2.112s) [317.072927] Starting dynamic subtest: reset [319.369612] Dynamic subtest reset: SUCCESS (2.307s) [319.380858] Starting dynamic subtest: memory_region [321.461398] Dynamic subtest memory_region: SUCCESS (2.088s) [321.472342] Starting dynamic subtest: hangcheck [346.604315] Dynamic subtest hangcheck: SUCCESS (25.142s) [346.615332] Starting dynamic subtest: execlists [356.851371] Dynamic subtest execlists: SUCCESS (10.246s) [356.863233] Starting dynamic subtest: ring_submission [358.948411] Dynamic subtest ring_submission: SUCCESS (2.096s) [358.961265] Starting dynamic subtest: perf [361.145593] Dynamic subtest perf: SUCCESS (2.199s) [361.156724] Starting dynamic subtest: slpc [363.268662] Dynamic subtest slpc: SUCCESS (2.122s) [363.279977] Starting dynamic subtest: guc [365.350743] Dynamic subtest guc: SUCCESS (2.081s) [365.361566] Starting dynamic subtest: guc_multi_lrc [367.430610] Dynamic subtest guc_multi_lrc: SUCCESS (2.079s) [367.445314] Starting dynamic subtest: guc_hang [369.535028] Dynamic subtest guc_hang: SUCCESS (2.103s) [369.545812] Starting dynamic subtest: late_gt_pm [371.741501] Dynamic subtest late_gt_pm: SUCCESS (2.149s) [371.805529] Subtest live: SUCCESS (166.703s) [372.189248] [162/162] (648s left) dmabuf (all-tests) [372.719835] Starting subtest: all-tests [372.724185] Starting dynamic subtest: sanitycheck [372.728214] Dynamic subtest sanitycheck: SUCCESS (0.091s) [372.740150] Starting dynamic subtest: dma_fence [372.823689] Dynamic subtest dma_fence: SUCCESS (0.174s) [372.840673] Starting dynamic subtest: dma_fence_chain [383.502023] Dynamic subtest dma_fence_chain: SUCCESS (10.677s) [383.514914] Starting dynamic subtest: dma_fence_unwrap [383.564901] Dynamic subtest dma_fence_unwrap: SUCCESS (0.060s) [383.589628] Starting dynamic subtest: dma_resv [383.646626] Dynamic subtest dma_resv: SUCCESS (0.078s) [383.651373] Subtest all-tests: SUCCESS (11.092s) [383.684774] 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.