[45.765619] Initializing watchdogs [45.765688] /dev/watchdog0 [45.774221] [001/170] (960s left) i915_module_load (load) [45.838887] Starting subtest: load [46.941567] Subtest load: SUCCESS (1.099s) [46.961889] [002/170] (959s left) core_auth (basic-auth) [47.058259] Starting subtest: basic-auth [47.061375] Subtest basic-auth: SUCCESS (0.000s) [47.117184] [003/170] (959s left) debugfs_test (read_all_entries) [47.184753] Starting subtest: read_all_entries [47.304613] Subtest read_all_entries: SUCCESS (0.121s) [47.419244] [004/170] (958s left) debugfs_test (basic-hwmon) [47.487877] Starting subtest: basic-hwmon [47.494459] Subtest basic-hwmon: SKIP (0.000s) [47.600546] [005/170] (958s left) fbdev (eof) [47.672705] Starting subtest: eof [47.676677] Subtest eof: SUCCESS (0.000s) [47.742344] [006/170] (958s left) fbdev (info) [47.842197] Starting subtest: info [47.845436] Subtest info: SUCCESS (0.000s) [47.904033] [007/170] (958s left) fbdev (nullptr) [47.987607] Starting subtest: nullptr [47.992153] Subtest nullptr: SUCCESS (0.000s) [48.066304] [008/170] (958s left) fbdev (read) [48.137436] Starting subtest: read [48.352927] Subtest read: SUCCESS (0.215s) [48.401355] [009/170] (958s left) fbdev (write) [48.471167] Starting subtest: write [48.580720] Subtest write: SUCCESS (0.110s) [48.618493] [010/170] (957s left) gem_basic (bad-close) [48.692745] Starting subtest: bad-close [48.699358] Subtest bad-close: SUCCESS (0.000s) [48.738253] [011/170] (957s left) gem_basic (create-close) [48.830577] Starting subtest: create-close [48.837868] Subtest create-close: SUCCESS (0.000s) [48.911162] [012/170] (957s left) gem_basic (create-fd-close) [48.983201] Starting subtest: create-fd-close [48.990471] Subtest create-fd-close: SUCCESS (0.000s) [49.063745] [013/170] (957s left) gem_busy (busy@all-engines) [49.185113] Starting subtest: busy [49.188378] Starting dynamic subtest: all-engines [49.205645] Dynamic subtest all-engines: SUCCESS (0.022s) [49.209190] Subtest busy: SUCCESS (0.022s) [49.546636] [014/170] (957s left) gem_close_race (basic-process) [49.612280] Starting subtest: basic-process [49.668468] Subtest basic-process: SUCCESS (0.056s) [49.856124] [015/170] (956s left) gem_close_race (basic-threads) [49.974196] Starting subtest: basic-threads [51.184452] Subtest basic-threads: SUCCESS (1.211s) [51.410891] [016/170] (955s left) gem_ctx_create (basic) [51.492523] Starting subtest: basic [51.495560] Subtest basic: SUCCESS (0.000s) [51.677938] [017/170] (955s left) gem_ctx_create (basic-files) [51.759199] Starting subtest: basic-files [53.766448] Subtest basic-files: SUCCESS (2.010s) [54.255399] [018/170] (952s left) gem_ctx_exec (basic) [54.812069] Starting subtest: basic [54.878045] Subtest basic: SUCCESS (0.002s) [55.140184] [019/170] (952s left) gem_exec_basic (basic) [55.399872] Starting subtest: basic [55.403098] Starting dynamic subtest: rcs0-smem [55.406885] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [55.423376] Starting dynamic subtest: bcs0-smem [55.427225] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [55.443565] Starting dynamic subtest: vcs0-smem [55.447424] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [55.463634] Starting dynamic subtest: vecs0-smem [55.467530] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [55.471406] Subtest basic: SUCCESS (0.002s) [55.643173] [020/170] (951s left) gem_exec_create (basic) [55.722088] Starting subtest: basic [55.725244] Starting dynamic subtest: smem [57.759552] Dynamic subtest smem: SUCCESS (2.040s) [57.763193] Subtest basic: SUCCESS (2.040s) [57.939358] [021/170] (949s left) gem_exec_fence (basic-busy) [58.153210] Starting subtest: basic-busy [58.157593] Starting dynamic subtest: rcs0 [58.191575] Dynamic subtest rcs0: SUCCESS (0.038s) [58.202740] Starting dynamic subtest: bcs0 [58.226200] Dynamic subtest bcs0: SUCCESS (0.036s) [58.233219] Starting dynamic subtest: vcs0 [58.260359] Dynamic subtest vcs0: SUCCESS (0.034s) [58.272986] Starting dynamic subtest: vecs0 [58.293517] Dynamic subtest vecs0: SUCCESS (0.032s) [58.297989] Subtest basic-busy: SUCCESS (0.140s) [58.862689] [022/170] (948s left) gem_exec_fence (basic-wait) [59.038075] Starting subtest: basic-wait [59.041607] Starting dynamic subtest: rcs0 [59.066497] Dynamic subtest rcs0: SUCCESS (0.028s) [59.077645] Starting dynamic subtest: bcs0 [59.094325] Dynamic subtest bcs0: SUCCESS (0.027s) [59.117997] Starting dynamic subtest: vcs0 [59.135846] Dynamic subtest vcs0: SUCCESS (0.041s) [59.159625] Starting dynamic subtest: vecs0 [59.163136] Dynamic subtest vecs0: SUCCESS (0.028s) [59.167053] Subtest basic-wait: SUCCESS (0.124s) [59.709298] [023/170] (947s left) gem_exec_fence (basic-await) [59.916177] Starting subtest: basic-await [59.920458] Starting dynamic subtest: rcs0 [60.004747] Dynamic subtest rcs0: SUCCESS (0.089s) [60.013224] Starting dynamic subtest: bcs0 [60.078870] Dynamic subtest bcs0: SUCCESS (0.073s) [60.101758] Starting dynamic subtest: vcs0 [60.177736] Dynamic subtest vcs0: SUCCESS (0.100s) [60.186417] Starting dynamic subtest: vecs0 [60.253300] Dynamic subtest vecs0: SUCCESS (0.075s) [60.257639] Subtest basic-await: SUCCESS (0.338s) [60.795297] [024/170] (946s left) gem_exec_fence (nb-await) [60.984994] Starting subtest: nb-await [60.988264] Starting dynamic subtest: rcs0 [61.044053] Dynamic subtest rcs0: SUCCESS (0.058s) [61.067591] Starting dynamic subtest: bcs0 [61.117400] Dynamic subtest bcs0: SUCCESS (0.073s) [61.140333] Starting dynamic subtest: vcs0 [61.187485] Dynamic subtest vcs0: SUCCESS (0.070s) [61.210307] Starting dynamic subtest: vecs0 [61.258358] Dynamic subtest vecs0: SUCCESS (0.071s) [61.262473] Subtest nb-await: SUCCESS (0.272s) [61.780059] [025/170] (945s left) gem_exec_gttfill (basic) [61.866619] Starting subtest: basic [66.586245] Subtest basic: SUCCESS (4.720s) [66.752062] [026/170] (940s left) gem_exec_parallel (engines) [66.877126] Starting subtest: engines [66.880254] Starting dynamic subtest: basic [68.285147] Dynamic subtest basic: SUCCESS (1.410s) [68.292222] Starting dynamic subtest: contexts [70.594695] Dynamic subtest contexts: SUCCESS (2.309s) [70.623280] Starting dynamic subtest: fds [73.037303] Dynamic subtest fds: SUCCESS (2.383s) [73.102654] Starting dynamic subtest: userptr [74.804749] Dynamic subtest userptr: SUCCESS (1.827s) [74.808280] Subtest engines: SUCCESS (7.929s) [75.015141] [027/170] (932s left) gem_exec_store (basic) [75.123564] Starting subtest: basic [75.167471] Subtest basic: SUCCESS (0.052s) [75.339313] [028/170] (932s left) gem_flink_basic (bad-flink) [75.413211] Starting subtest: bad-flink [75.416503] Subtest bad-flink: SUCCESS (0.000s) [75.471454] [029/170] (931s left) gem_flink_basic (bad-open) [75.533987] Starting subtest: bad-open [75.537387] Subtest bad-open: SUCCESS (0.000s) [75.600366] [030/170] (931s left) gem_flink_basic (basic) [75.698514] Starting subtest: basic [75.701800] Subtest basic: SUCCESS (0.000s) [75.783709] [031/170] (931s left) gem_flink_basic (double-flink) [75.858417] Starting subtest: double-flink [75.861792] Subtest double-flink: SUCCESS (0.000s) [75.961572] [032/170] (931s left) gem_flink_basic (flink-lifetime) [76.034970] Starting subtest: flink-lifetime [76.038285] Subtest flink-lifetime: SUCCESS (0.001s) [76.125482] [033/170] (931s left) gem_huc_copy (huc-copy) [76.233251] Starting subtest: huc-copy [76.236575] Subtest huc-copy: SUCCESS (0.002s) [76.338357] [034/170] (931s left) gem_linear_blits (basic) [76.515075] Starting subtest: basic [76.522391] Subtest basic: SUCCESS (0.004s) [76.657246] [035/170] (931s left) gem_mmap (basic) [76.820035] Starting subtest: basic [76.836692] Subtest basic: SUCCESS (0.000s) [76.889685] [036/170] (930s left) gem_mmap_gtt (basic) [76.954460] Starting subtest: basic [76.958006] Subtest basic: SUCCESS (0.000s) [76.998942] [037/170] (930s left) gem_render_linear_blits (basic) [77.062330] Starting subtest: basic [77.080953] Subtest basic: SUCCESS (0.017s) [77.114386] [038/170] (930s left) gem_render_tiled_blits (basic) [77.180563] Starting subtest: basic [77.202011] Subtest basic: SUCCESS (0.022s) [77.231169] [039/170] (930s left) gem_ringfill (basic-all) [77.476651] Starting subtest: basic-all [78.630050] Subtest basic-all: SUCCESS (1.150s) [78.729294] [040/170] (929s left) gem_softpin (allocator-basic) [78.827931] Starting subtest: allocator-basic [78.883619] Subtest allocator-basic: SUCCESS (0.058s) [79.014372] [041/170] (928s left) gem_softpin (allocator-basic-reserve) [79.088854] Starting subtest: allocator-basic-reserve [79.143671] Subtest allocator-basic-reserve: SUCCESS (0.058s) [79.250333] [042/170] (928s left) gem_softpin (safe-alignment) [79.321984] Starting subtest: safe-alignment [79.328568] Subtest safe-alignment: SUCCESS (0.007s) [79.454887] [043/170] (928s left) gem_sync (basic-all) [79.552465] Starting subtest: basic-all [81.731897] Subtest basic-all: SUCCESS (2.202s) [81.923329] [044/170] (926s left) gem_sync (basic-each) [82.016653] Starting subtest: basic-each [84.072895] Subtest basic-each: SUCCESS (2.079s) [84.299455] [045/170] (923s left) gem_tiled_blits (basic) [84.481802] Starting subtest: basic [84.492249] Subtest basic: SUCCESS (0.011s) [84.674378] [046/170] (923s left) gem_tiled_fence_blits (basic) [84.986369] Starting subtest: basic [84.993727] Subtest basic: SUCCESS (0.007s) [85.159419] [047/170] (922s left) gem_tiled_pread_basic [85.559448] [048/170] (922s left) gem_wait (busy@all-engines) [85.644252] Starting subtest: busy [85.647497] Starting dynamic subtest: all-engines [86.161164] Dynamic subtest all-engines: SUCCESS (0.517s) [86.164156] Subtest busy: SUCCESS (0.517s) [86.338636] [049/170] (921s left) gem_wait (wait@all-engines) [86.411762] Starting subtest: wait [86.414754] Starting dynamic subtest: all-engines [87.443669] Dynamic subtest all-engines: SUCCESS (1.030s) [87.448090] Subtest wait: SUCCESS (1.031s) [87.680369] [050/170] (920s left) i915_getparams_basic (basic-eu-total) [87.740583] Starting subtest: basic-eu-total [87.747755] Subtest basic-eu-total: SUCCESS (0.000s) [87.789528] [051/170] (920s left) i915_getparams_basic (basic-subslice-total) [87.868349] Starting subtest: basic-subslice-total [87.874727] Subtest basic-subslice-total: SUCCESS (0.000s) [87.922416] [052/170] (920s left) i915_hangman (error-state-basic) [88.014516] Starting subtest: error-state-basic [88.065193] Subtest error-state-basic: SUCCESS (0.050s) [88.122892] [053/170] (920s left) i915_pciid [88.254643] [054/170] (919s left) kms_addfb_basic (addfb25-bad-modifier) [88.322682] Starting subtest: addfb25-bad-modifier [88.325960] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [88.452269] [055/170] (919s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [88.512319] Starting subtest: addfb25-framebuffer-vs-set-tiling [88.515429] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [88.636242] [056/170] (919s left) kms_addfb_basic (addfb25-modifier-no-flag) [88.695559] Starting subtest: addfb25-modifier-no-flag [88.698742] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [88.802092] [057/170] (919s left) kms_addfb_basic (addfb25-x-tiled-legacy) [88.862663] Starting subtest: addfb25-x-tiled-legacy [88.865799] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [88.986157] [058/170] (919s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [89.048573] Starting subtest: addfb25-x-tiled-mismatch-legacy [89.052187] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [89.185601] [059/170] (919s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [89.290483] Starting subtest: addfb25-yf-tiled-legacy [89.293635] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [89.369211] [060/170] (918s left) kms_addfb_basic (addfb25-y-tiled-legacy) [89.475055] Starting subtest: addfb25-y-tiled-legacy [89.478151] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [89.535283] [061/170] (918s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [89.640718] Starting subtest: addfb25-y-tiled-small-legacy [89.643754] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [89.701962] [062/170] (918s left) kms_addfb_basic (bad-pitch-0) [89.769775] Starting subtest: bad-pitch-0 [89.773215] Subtest bad-pitch-0: SUCCESS (0.000s) [89.902797] [063/170] (918s left) kms_addfb_basic (bad-pitch-1024) [89.963863] Starting subtest: bad-pitch-1024 [89.966938] Subtest bad-pitch-1024: SUCCESS (0.000s) [90.086585] [064/170] (918s left) kms_addfb_basic (bad-pitch-128) [90.147486] Starting subtest: bad-pitch-128 [90.150603] Subtest bad-pitch-128: SUCCESS (0.000s) [90.252198] [065/170] (918s left) kms_addfb_basic (bad-pitch-256) [90.312841] Starting subtest: bad-pitch-256 [90.316225] Subtest bad-pitch-256: SUCCESS (0.000s) [90.436318] [066/170] (918s left) kms_addfb_basic (bad-pitch-32) [90.496792] Starting subtest: bad-pitch-32 [90.500143] Subtest bad-pitch-32: SUCCESS (0.000s) [90.619575] [067/170] (917s left) kms_addfb_basic (bad-pitch-63) [90.682425] Starting subtest: bad-pitch-63 [90.685848] Subtest bad-pitch-63: SUCCESS (0.000s) [90.807310] [068/170] (917s left) kms_addfb_basic (bad-pitch-65536) [90.870388] Starting subtest: bad-pitch-65536 [90.873552] Subtest bad-pitch-65536: SUCCESS (0.000s) [90.985746] [069/170] (917s left) kms_addfb_basic (bad-pitch-999) [91.045293] Starting subtest: bad-pitch-999 [91.048624] Subtest bad-pitch-999: SUCCESS (0.000s) [91.169642] [070/170] (917s left) kms_addfb_basic (basic) [91.231417] Starting subtest: basic [91.234614] Subtest basic: SUCCESS (0.000s) [91.352662] [071/170] (917s left) kms_addfb_basic (basic-x-tiled-legacy) [91.415447] Starting subtest: basic-x-tiled-legacy [91.418846] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [91.552251] [072/170] (916s left) kms_addfb_basic (basic-y-tiled-legacy) [91.611319] Starting subtest: basic-y-tiled-legacy [91.614601] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [91.718915] [073/170] (916s left) kms_addfb_basic (bo-too-small) [91.823999] Starting subtest: bo-too-small [91.826792] Subtest bo-too-small: SUCCESS (0.000s) [91.901859] [074/170] (916s left) kms_addfb_basic (bo-too-small-due-to-tiling) [92.006465] Starting subtest: bo-too-small-due-to-tiling [92.009487] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [92.068265] [075/170] (916s left) kms_addfb_basic (clobberred-modifier) [92.128337] Starting subtest: clobberred-modifier [92.131280] Subtest clobberred-modifier: SUCCESS (0.000s) [92.252252] [076/170] (916s left) kms_addfb_basic (framebuffer-vs-set-tiling) [92.311067] Starting subtest: framebuffer-vs-set-tiling [92.313973] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [92.418927] [077/170] (916s left) kms_addfb_basic (invalid-get-prop) [92.483293] Starting subtest: invalid-get-prop [92.487562] Subtest invalid-get-prop: SUCCESS (0.000s) [92.619288] [078/170] (916s left) kms_addfb_basic (invalid-get-prop-any) [92.682907] Starting subtest: invalid-get-prop-any [92.686392] Subtest invalid-get-prop-any: SUCCESS (0.000s) [92.836218] [079/170] (915s left) kms_addfb_basic (invalid-set-prop) [92.903270] Starting subtest: invalid-set-prop [92.906608] Subtest invalid-set-prop: SUCCESS (0.000s) [93.036205] [080/170] (915s left) kms_addfb_basic (invalid-set-prop-any) [93.098801] Starting subtest: invalid-set-prop-any [93.102166] Subtest invalid-set-prop-any: SUCCESS (0.000s) [93.219585] [081/170] (915s left) kms_addfb_basic (no-handle) [93.281371] Starting subtest: no-handle [93.284548] Subtest no-handle: SUCCESS (0.000s) [93.385589] [082/170] (915s left) kms_addfb_basic (size-max) [93.503589] Starting subtest: size-max [93.506634] Subtest size-max: SUCCESS (0.000s) [93.569214] [083/170] (915s left) kms_addfb_basic (small-bo) [93.674805] Starting subtest: small-bo [93.677988] Subtest small-bo: SUCCESS (0.000s) [93.735360] [084/170] (915s left) kms_addfb_basic (tile-pitch-mismatch) [93.796345] Starting subtest: tile-pitch-mismatch [93.799593] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [93.902188] [085/170] (914s left) kms_addfb_basic (too-high) [94.007821] Starting subtest: too-high [94.010982] Subtest too-high: SUCCESS (0.000s) [94.068915] [086/170] (914s left) kms_addfb_basic (too-wide) [94.175986] Starting subtest: too-wide [94.179238] Subtest too-wide: SUCCESS (0.000s) [94.253167] [087/170] (914s left) kms_addfb_basic (unused-handle) [94.340300] Starting subtest: unused-handle [94.343323] Subtest unused-handle: SUCCESS (0.000s) [94.436802] [088/170] (914s left) kms_addfb_basic (unused-modifier) [94.501147] Starting subtest: unused-modifier [94.504843] Subtest unused-modifier: SUCCESS (0.000s) [94.636233] [089/170] (914s left) kms_addfb_basic (unused-offsets) [94.696342] Starting subtest: unused-offsets [94.699542] Subtest unused-offsets: SUCCESS (0.000s) [94.819345] [090/170] (914s left) kms_addfb_basic (unused-pitches) [94.878279] Starting subtest: unused-pitches [94.881707] Subtest unused-pitches: SUCCESS (0.000s) [95.002631] [091/170] (913s left) kms_busy (basic) [95.114543] Starting subtest: basic [95.117256] Starting dynamic subtest: flip [95.769846] Dynamic subtest flip: SUCCESS (0.576s) [95.834638] Starting dynamic subtest: modeset [96.291841] Dynamic subtest modeset: SUCCESS (0.500s) [96.357494] Subtest basic: SUCCESS (1.076s) [96.619269] [092/170] (912s left) kms_chamelium_hpd (dp-hpd-fast) [97.056336] Subtest dp-hpd-fast: SKIP (0.000s) [97.125472] [093/170] (911s left) kms_chamelium_edid (dp-edid-read) [97.284361] Subtest dp-edid-read: SKIP (0.000s) [97.349050] [094/170] (911s left) kms_chamelium_frames (dp-crc-fast) [97.509119] Subtest dp-crc-fast: SKIP (0.000s) [97.573439] [095/170] (911s left) kms_chamelium_hpd (hdmi-hpd-fast) [97.736800] Subtest hdmi-hpd-fast: SKIP (0.000s) [97.798125] [096/170] (911s left) kms_chamelium_edid (hdmi-edid-read) [97.958634] Subtest hdmi-edid-read: SKIP (0.000s) [98.024621] [097/170] (911s left) kms_chamelium_frames (hdmi-crc-fast) [98.186328] Subtest hdmi-crc-fast: SKIP (0.000s) [98.254703] [098/170] (910s left) kms_chamelium_hpd (vga-hpd-fast) [98.412306] Subtest vga-hpd-fast: SKIP (0.000s) [98.478140] [099/170] (910s left) kms_chamelium_edid (vga-edid-read) [98.638364] Subtest vga-edid-read: SKIP (0.000s) [98.702772] [100/170] (910s left) kms_prop_blob (basic) [98.763827] Starting subtest: basic [98.767035] Subtest basic: SUCCESS (0.000s) [98.820963] [101/170] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [98.926967] Starting subtest: basic-busy-flip-before-cursor-atomic [98.933103] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [98.988574] [102/170] (910s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [99.096979] Starting subtest: basic-busy-flip-before-cursor-legacy [99.102371] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [99.154215] [103/170] (910s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [99.258989] Starting subtest: basic-flip-after-cursor-atomic [100.194926] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.935s) [100.325221] [104/170] (908s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [100.434121] Starting subtest: basic-flip-after-cursor-legacy [101.380755] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.947s) [101.494932] [105/170] (907s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [101.602056] Starting subtest: basic-flip-after-cursor-varying-size [102.568809] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.966s) [102.673927] [106/170] (906s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [102.780566] Starting subtest: basic-flip-before-cursor-atomic [103.713026] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.933s) [103.838526] [107/170] (905s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [103.943790] Starting subtest: basic-flip-before-cursor-legacy [104.895814] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.952s) [105.013663] [108/170] (904s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [105.120175] Starting subtest: basic-flip-before-cursor-varying-size [106.052733] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.933s) [106.169641] [109/170] (903s left) kms_flip (basic-flip-vs-dpms) [106.266243] Starting subtest: basic-flip-vs-dpms [106.269302] Starting dynamic subtest: A-HDMI-A1 [107.221849] Dynamic subtest A-HDMI-A1: SUCCESS (0.955s) [107.229792] Starting dynamic subtest: B-HDMI-A1 [108.112505] Dynamic subtest B-HDMI-A1: SUCCESS (0.890s) [108.121308] Starting dynamic subtest: C-HDMI-A1 [109.001243] Dynamic subtest C-HDMI-A1: SUCCESS (0.889s) [109.004401] Subtest basic-flip-vs-dpms: SUCCESS (2.738s) [109.117294] [110/170] (900s left) kms_flip (basic-flip-vs-modeset) [109.217187] Starting subtest: basic-flip-vs-modeset [109.220192] Starting dynamic subtest: A-HDMI-A1 [110.076780] Dynamic subtest A-HDMI-A1: SUCCESS (0.860s) [110.084461] Starting dynamic subtest: B-HDMI-A1 [110.869789] Dynamic subtest B-HDMI-A1: SUCCESS (0.793s) [110.877380] Starting dynamic subtest: C-HDMI-A1 [111.662567] Dynamic subtest C-HDMI-A1: SUCCESS (0.793s) [111.665511] Subtest basic-flip-vs-modeset: SUCCESS (2.450s) [111.790387] [111/170] (897s left) kms_flip (basic-flip-vs-wf_vblank) [111.891290] Starting subtest: basic-flip-vs-wf_vblank [111.894393] Starting dynamic subtest: A-HDMI-A1 [113.031889] Dynamic subtest A-HDMI-A1: SUCCESS (1.143s) [113.039525] Starting dynamic subtest: B-HDMI-A1 [114.155994] Dynamic subtest B-HDMI-A1: SUCCESS (1.124s) [114.163693] Starting dynamic subtest: C-HDMI-A1 [115.293328] Dynamic subtest C-HDMI-A1: SUCCESS (1.137s) [115.296664] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.408s) [115.481116] [112/170] (893s left) kms_flip (basic-plain-flip) [115.584735] Starting subtest: basic-plain-flip [115.587634] Starting dynamic subtest: A-HDMI-A1 [116.457838] Dynamic subtest A-HDMI-A1: SUCCESS (0.872s) [116.465595] Starting dynamic subtest: B-HDMI-A1 [117.293753] Dynamic subtest B-HDMI-A1: SUCCESS (0.838s) [117.301471] Starting dynamic subtest: C-HDMI-A1 [118.133174] Dynamic subtest C-HDMI-A1: SUCCESS (0.839s) [118.136351] Subtest basic-plain-flip: SUCCESS (2.555s) [118.285869] [113/170] (891s left) kms_force_connector_basic (force-connector-state) [118.445844] Starting subtest: force-connector-state [118.823270] Subtest force-connector-state: SUCCESS (0.377s) [119.225152] [114/170] (890s left) kms_force_connector_basic (force-edid) [119.382916] Starting subtest: force-edid [119.524660] Subtest force-edid: SUCCESS (0.142s) [119.725169] [115/170] (889s left) kms_force_connector_basic (force-load-detect) [119.882531] Starting subtest: force-load-detect [119.888771] Subtest force-load-detect: SKIP (0.000s) [120.075074] [116/170] (889s left) kms_force_connector_basic (prune-stale-modes) [120.232633] Starting subtest: prune-stale-modes [120.367293] Subtest prune-stale-modes: SUCCESS (0.136s) [120.557831] [117/170] (888s left) kms_frontbuffer_tracking (basic) [120.678202] Starting subtest: basic [123.009580] Subtest basic: SUCCESS (2.342s) [123.096600] [118/170] (886s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [123.208429] Starting subtest: compare-crc-sanitycheck [123.211615] Starting dynamic subtest: pipe-A-HDMI-A-1 [123.598209] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.389s) [123.607176] Starting dynamic subtest: pipe-B-HDMI-A-1 [123.998706] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.399s) [124.006436] Starting dynamic subtest: pipe-C-HDMI-A-1 [124.403519] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.402s) [124.406640] Subtest compare-crc-sanitycheck: SUCCESS (1.195s) [124.528871] [119/170] (885s left) kms_pipe_crc_basic (hang-read-crc) [124.636742] Starting subtest: hang-read-crc [124.639590] Starting dynamic subtest: pipe-A-HDMI-A-1 [125.589748] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.952s) [125.598614] Starting dynamic subtest: pipe-B-HDMI-A-1 [126.550667] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.959s) [126.558610] Starting dynamic subtest: pipe-C-HDMI-A-1 [127.575534] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.023s) [127.578687] Subtest hang-read-crc: SUCCESS (2.939s) [127.672295] [120/170] (881s left) kms_pipe_crc_basic (nonblocking-crc) [127.780219] Starting subtest: nonblocking-crc [127.783254] Starting dynamic subtest: pipe-A-HDMI-A-1 [128.294869] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.514s) [128.303801] Starting dynamic subtest: pipe-B-HDMI-A-1 [128.842732] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.546s) [128.850951] Starting dynamic subtest: pipe-C-HDMI-A-1 [129.420992] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.576s) [129.424429] Subtest nonblocking-crc: SUCCESS (1.641s) [129.519128] [121/170] (880s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [129.624973] Starting subtest: nonblocking-crc-frame-sequence [129.628121] Starting dynamic subtest: pipe-A-HDMI-A-1 [130.142182] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.514s) [130.151278] Starting dynamic subtest: pipe-B-HDMI-A-1 [130.669041] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.525s) [130.678280] Starting dynamic subtest: pipe-C-HDMI-A-1 [131.234417] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.564s) [131.237368] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.609s) [131.333106] [122/170] (878s left) kms_pipe_crc_basic (read-crc) [131.439615] Starting subtest: read-crc [131.442496] Starting dynamic subtest: pipe-A-HDMI-A-1 [131.922795] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.481s) [131.931454] Starting dynamic subtest: pipe-B-HDMI-A-1 [132.383828] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.459s) [132.392693] Starting dynamic subtest: pipe-C-HDMI-A-1 [132.880948] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.495s) [132.884036] Subtest read-crc: SUCCESS (1.440s) [132.978905] [123/170] (876s left) kms_pipe_crc_basic (read-crc-frame-sequence) [133.085282] Starting subtest: read-crc-frame-sequence [133.088110] Starting dynamic subtest: pipe-A-HDMI-A-1 [133.534837] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.448s) [133.543213] Starting dynamic subtest: pipe-B-HDMI-A-1 [133.998936] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.462s) [134.007535] Starting dynamic subtest: pipe-C-HDMI-A-1 [134.499541] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.498s) [134.502642] Subtest read-crc-frame-sequence: SUCCESS (1.413s) [134.599052] [124/170] (875s left) kms_psr (primary_page_flip) [134.665176] Subtest primary_page_flip: SKIP (0.000s) [134.683248] [125/170] (874s left) kms_psr (cursor_plane_move) [134.744830] Subtest cursor_plane_move: SKIP (0.000s) [134.763121] [126/170] (874s left) kms_psr (sprite_plane_onoff) [134.884229] Subtest sprite_plane_onoff: SKIP (0.000s) [134.928391] [127/170] (874s left) kms_psr (primary_mmap_gtt) [135.050536] Subtest primary_mmap_gtt: SKIP (0.000s) [135.067222] [128/170] (874s left) kms_setmode (basic-clone-single-crtc) [135.133374] Starting subtest: basic-clone-single-crtc [135.145606] Subtest basic-clone-single-crtc: SKIP (0.000s) [135.213520] [129/170] (874s left) i915_pm_backlight (basic-brightness) [135.368976] Subtest basic-brightness: SKIP (0.000s) [135.393688] [130/170] (874s left) i915_pm_rpm (basic-pci-d3-state) [137.069043] Starting subtest: basic-pci-d3-state [137.380564] Subtest basic-pci-d3-state: SUCCESS (0.437s) [137.492675] [131/170] (872s left) i915_pm_rpm (basic-rte) [137.554254] Starting subtest: basic-rte [139.490461] Subtest basic-rte: SUCCESS (1.935s) [142.598347] [132/170] (867s left) i915_pm_rps (basic-api) [142.663042] Starting subtest: basic-api [142.666421] Subtest basic-api: SUCCESS (0.002s) [142.718359] [133/170] (867s left) prime_self_import (basic-llseek-bad) [142.780991] Starting subtest: basic-llseek-bad [142.787154] Subtest basic-llseek-bad: SUCCESS (0.001s) [142.895862] [134/170] (866s left) prime_self_import (basic-llseek-size) [142.995204] Starting subtest: basic-llseek-size [143.001157] Subtest basic-llseek-size: SUCCESS (0.001s) [143.073129] [135/170] (866s left) prime_self_import (basic-with_fd_dup) [143.156953] Starting subtest: basic-with_fd_dup [143.162734] Subtest basic-with_fd_dup: SUCCESS (0.001s) [143.244270] [136/170] (866s left) prime_self_import (basic-with_one_bo) [143.340425] Starting subtest: basic-with_one_bo [143.346143] Subtest basic-with_one_bo: SUCCESS (0.002s) [143.418525] [137/170] (866s left) prime_self_import (basic-with_one_bo_two_files) [143.505485] Starting subtest: basic-with_one_bo_two_files [143.512276] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [143.634985] [138/170] (866s left) prime_self_import (basic-with_two_bos) [143.729692] Starting subtest: basic-with_two_bos [143.736238] Subtest basic-with_two_bos: SUCCESS (0.001s) [143.808270] [139/170] (866s left) prime_vgem (basic-fence-flip) [143.902367] Starting subtest: basic-fence-flip [144.283641] Subtest basic-fence-flip: SUCCESS (0.382s) [144.369657] [140/170] (865s left) prime_vgem (basic-fence-mmap) [144.461985] Starting subtest: basic-fence-mmap [144.475897] Subtest basic-fence-mmap: SUCCESS (0.016s) [144.613446] [141/170] (865s left) prime_vgem (basic-fence-read) [144.733663] Starting subtest: basic-fence-read [144.756835] Subtest basic-fence-read: SUCCESS (0.025s) [144.879910] [142/170] (865s left) prime_vgem (basic-gtt) [144.989121] Starting subtest: basic-gtt [144.996391] Subtest basic-gtt: SUCCESS (0.007s) [145.124294] [143/170] (865s left) prime_vgem (basic-read) [145.228678] Starting subtest: basic-read [145.236682] Subtest basic-read: SUCCESS (0.011s) [145.356148] [144/170] (864s left) prime_vgem (basic-write) [145.439522] Starting subtest: basic-write [145.448277] Subtest basic-write: SUCCESS (0.012s) [145.522140] [145/170] (864s left) vgem_basic (setversion) [145.619362] Starting subtest: setversion [145.626141] Subtest setversion: SUCCESS (0.000s) [145.703126] [146/170] (864s left) vgem_basic (create) [145.786735] Starting subtest: create [145.790670] Subtest create: SUCCESS (0.000s) [145.870482] [147/170] (864s left) vgem_basic (debugfs) [145.986819] Starting subtest: debugfs [145.990667] Subtest debugfs: SUCCESS (0.001s) [146.055732] [148/170] (864s left) vgem_basic (dmabuf-export) [146.142384] Starting subtest: dmabuf-export [146.148959] Subtest dmabuf-export: SUCCESS (0.004s) [146.281747] [149/170] (864s left) vgem_basic (dmabuf-fence) [146.386124] Starting subtest: dmabuf-fence [146.389636] Subtest dmabuf-fence: SUCCESS (0.000s) [146.435444] [150/170] (864s left) vgem_basic (dmabuf-fence-before) [146.507449] Starting subtest: dmabuf-fence-before [146.511890] Subtest dmabuf-fence-before: SUCCESS (0.000s) [146.597228] [151/170] (863s left) vgem_basic (dmabuf-mmap) [146.702572] Starting subtest: dmabuf-mmap [146.709416] Subtest dmabuf-mmap: SUCCESS (0.008s) [146.775662] [152/170] (863s left) vgem_basic (mmap) [146.855177] Starting subtest: mmap [146.869439] Subtest mmap: SUCCESS (0.017s) [146.921860] [153/170] (863s left) vgem_basic (second-client) [147.002931] Starting subtest: second-client [147.049641] Subtest second-client: SUCCESS (0.050s) [147.148409] [154/170] (863s left) vgem_basic (sysfs) [147.269468] Starting subtest: sysfs [147.273091] Subtest sysfs: SUCCESS (0.000s) [147.345704] [155/170] (863s left) core_hotunplug (unbind-rebind) [147.517972] Starting subtest: unbind-rebind [148.517634] Subtest unbind-rebind: SUCCESS (1.000s) [148.536904] [156/170] (862s left) vgem_basic (unload) [148.599280] Starting subtest: unload [177.479702] Subtest unload: SUCCESS (28.879s) [177.577233] [157/170] (833s left) i915_module_load (reload) [177.636729] Starting subtest: reload [179.724069] Subtest reload: SUCCESS (2.086s) [179.748469] [158/170] (831s left) gem_lmem_swapping (basic) [179.833604] Subtest basic: SKIP (0.000s) [179.851008] [159/170] (831s left) gem_lmem_swapping (parallel-random-engines) [179.925798] Subtest parallel-random-engines: SKIP (0.000s) [179.942307] [160/170] (830s left) gem_lmem_swapping (random-engines) [180.009856] Subtest random-engines: SKIP (0.000s) [180.032404] [161/170] (830s left) gem_lmem_swapping (verify-random) [180.099549] Subtest verify-random: SKIP (0.000s) [180.117671] [162/170] (830s left) i915_pm_rpm (module-reload) [181.836753] Starting subtest: module-reload [189.963784] Subtest module-reload: SUCCESS (8.127s) [190.019770] [163/170] (820s left) i915_selftest (live) [190.096591] Starting subtest: live [190.099789] Starting dynamic subtest: sanitycheck [190.652347] Dynamic subtest sanitycheck: SUCCESS (0.508s) [190.717688] Starting dynamic subtest: uncore [191.206924] Dynamic subtest uncore: SUCCESS (0.539s) [191.272516] Starting dynamic subtest: workarounds [191.826496] Dynamic subtest workarounds: SUCCESS (0.683s) [191.833292] Starting dynamic subtest: gt_engines [192.836631] Dynamic subtest gt_engines: SUCCESS (1.010s) [192.843943] Starting dynamic subtest: gt_timelines [198.678573] Dynamic subtest gt_timelines: SUCCESS (5.842s) [198.685609] Starting dynamic subtest: gt_contexts [199.334612] Dynamic subtest gt_contexts: SUCCESS (0.656s) [199.342181] Starting dynamic subtest: gt_lrc [202.174573] Dynamic subtest gt_lrc: SUCCESS (2.840s) [202.182108] Starting dynamic subtest: gt_mocs [202.777462] Dynamic subtest gt_mocs: SUCCESS (0.603s) [202.784644] Starting dynamic subtest: gt_pm [205.215263] Dynamic subtest gt_pm: SUCCESS (2.438s) [205.222208] Starting dynamic subtest: gt_heartbeat [205.878668] Dynamic subtest gt_heartbeat: SUCCESS (0.663s) [205.887146] Starting dynamic subtest: gt_tlb [207.312426] Dynamic subtest gt_tlb: SUCCESS (1.434s) [207.322138] Starting dynamic subtest: requests [214.040735] Dynamic subtest requests: SUCCESS (6.728s) [214.048265] Starting dynamic subtest: migrate [217.481464] Dynamic subtest migrate: SUCCESS (3.441s) [217.488774] Starting dynamic subtest: active [218.010238] Dynamic subtest active: SUCCESS (0.527s) [218.033644] Starting dynamic subtest: objects [219.113439] Dynamic subtest objects: SUCCESS (1.103s) [219.120631] Starting dynamic subtest: mman [222.950605] Dynamic subtest mman: SUCCESS (3.837s) [222.958676] Starting dynamic subtest: dmabuf [223.543648] Dynamic subtest dmabuf: SUCCESS (0.593s) [223.551010] Starting dynamic subtest: vma [224.045764] Dynamic subtest vma: SUCCESS (0.502s) [224.055920] Starting dynamic subtest: coherency [225.123628] Dynamic subtest coherency: SUCCESS (1.078s) [225.131118] Starting dynamic subtest: gtt [232.587753] Dynamic subtest gtt: SUCCESS (7.464s) [232.594995] Starting dynamic subtest: gem [233.306591] Dynamic subtest gem: SUCCESS (0.719s) [233.314467] Starting dynamic subtest: evict [234.615444] Dynamic subtest evict: SUCCESS (1.309s) [234.622997] Starting dynamic subtest: hugepages [240.204462] Dynamic subtest hugepages: SUCCESS (5.589s) [240.211959] Starting dynamic subtest: gem_contexts [252.214922] Dynamic subtest gem_contexts: SUCCESS (12.010s) [252.222449] Starting dynamic subtest: client [252.761492] Dynamic subtest client: SUCCESS (0.547s) [252.769339] Starting dynamic subtest: gem_migrate [253.268693] Dynamic subtest gem_migrate: SUCCESS (0.507s) [253.276504] Starting dynamic subtest: reset [254.221880] Dynamic subtest reset: SUCCESS (0.908s) [254.287536] Starting dynamic subtest: memory_region [254.745042] Dynamic subtest memory_region: SUCCESS (0.528s) [254.811010] Starting dynamic subtest: hangcheck [278.222571] Dynamic subtest hangcheck: SUCCESS (23.518s) [278.229552] Starting dynamic subtest: execlists [286.531638] Dynamic subtest execlists: SUCCESS (8.309s) [286.539548] Starting dynamic subtest: ring_submission [287.073651] Dynamic subtest ring_submission: SUCCESS (0.542s) [287.081236] Starting dynamic subtest: perf [287.674521] Dynamic subtest perf: SUCCESS (0.601s) [287.682348] Starting dynamic subtest: slpc [288.214472] Dynamic subtest slpc: SUCCESS (0.540s) [288.221797] Starting dynamic subtest: guc [288.746554] Dynamic subtest guc: SUCCESS (0.532s) [288.754202] Starting dynamic subtest: guc_multi_lrc [289.260562] Dynamic subtest guc_multi_lrc: SUCCESS (0.514s) [289.268170] Starting dynamic subtest: guc_hang [289.783774] Dynamic subtest guc_hang: SUCCESS (0.523s) [289.792502] Starting dynamic subtest: late_gt_pm [290.362651] Dynamic subtest late_gt_pm: SUCCESS (0.578s) [290.366092] Subtest live: SUCCESS (100.266s) [290.564659] [164/170] (720s left) dmabuf (all-tests) [290.687245] Starting subtest: all-tests [290.690379] Starting dynamic subtest: sanitycheck [290.744560] Dynamic subtest sanitycheck: SUCCESS (0.060s) [290.756113] Starting dynamic subtest: dma_fence [290.919372] Dynamic subtest dma_fence: SUCCESS (0.174s) [290.931912] Starting dynamic subtest: dma_fence_chain [301.222357] Dynamic subtest dma_fence_chain: SUCCESS (10.302s) [301.231820] Starting dynamic subtest: dma_fence_unwrap [301.292463] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s) [301.300549] Starting dynamic subtest: dma_resv [301.359268] Dynamic subtest dma_resv: SUCCESS (0.066s) [301.363611] Subtest all-tests: SUCCESS (10.675s) [301.411894] [165/170] (709s left) i915_suspend (basic-s2idle-without-i915) [301.508899] Starting subtest: basic-s2idle-without-i915 [319.418330] Subtest basic-s2idle-without-i915: SUCCESS (2.374s) [324.572548] [166/170] (707s left) i915_suspend (basic-s3-without-i915) [324.634421] Starting subtest: basic-s3-without-i915 [342.579032] Subtest basic-s3-without-i915: SUCCESS (2.153s) [350.743723] [167/170] (704s left) gem_exec_suspend (basic-s0) [350.822661] Starting subtest: basic-S0 [350.825890] Starting dynamic subtest: smem [368.443989] Dynamic subtest smem: SUCCESS (1.753s) [368.447063] Subtest basic-S0: SUCCESS (1.754s) [375.646849] [168/170] (702s left) gem_exec_suspend (basic-s3) [375.747899] Starting subtest: basic-S3 [375.751249] Starting dynamic subtest: smem [393.585220] Dynamic subtest smem: SUCCESS (1.951s) [393.588588] Subtest basic-S3: SUCCESS (1.952s) [402.783354] [169/170] (700s left) kms_chamelium_hpd (common-hpd-after-suspend) [402.960921] Subtest common-hpd-after-suspend: SKIP (0.000s) [403.028126] [170/170] (700s left) kms_pipe_crc_basic (suspend-read-crc) [403.135373] Starting subtest: suspend-read-crc [403.138625] Starting dynamic subtest: pipe-A-HDMI-A-1 [421.702810] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.864s) [421.713077] Starting dynamic subtest: pipe-B-HDMI-A-1 [440.730224] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.878s) [440.739152] Starting dynamic subtest: pipe-C-HDMI-A-1 [459.765392] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.042s) [459.768665] Subtest suspend-read-crc: SUCCESS (5.789s) [465.839550] Closing watchdogs Done.