[48.934745] Initializing watchdogs [48.934979] /dev/watchdog0 [48.946121] [001/170] (960s left) i915_module_load (load) [49.098497] Starting subtest: load [50.876323] Subtest load: SUCCESS (1.779s) [50.930814] [002/170] (958s left) core_auth (basic-auth) [51.240198] Starting subtest: basic-auth [51.245061] Subtest basic-auth: SUCCESS (0.001s) [51.342157] [003/170] (958s left) debugfs_test (read_all_entries) [51.661130] Starting subtest: read_all_entries [51.853341] Subtest read_all_entries: SUCCESS (0.184s) [52.032736] [004/170] (957s left) debugfs_test (basic-hwmon) [52.241136] Starting subtest: basic-hwmon [52.244466] Subtest basic-hwmon: SKIP (0.000s) [52.434398] [005/170] (957s left) fbdev (eof) [52.660596] Starting subtest: eof [52.661701] Subtest eof: SUCCESS (0.000s) [52.728405] [006/170] (956s left) fbdev (info) [52.946457] Starting subtest: info [52.947621] Subtest info: SUCCESS (0.000s) [53.028284] [007/170] (956s left) fbdev (nullptr) [53.244346] Starting subtest: nullptr [53.245440] Subtest nullptr: SUCCESS (0.000s) [53.302137] [008/170] (956s left) fbdev (read) [53.443198] Starting subtest: read [55.012337] Subtest read: SUCCESS (1.567s) [55.073280] [009/170] (954s left) fbdev (write) [55.228459] Starting subtest: write [56.066759] Subtest write: SUCCESS (0.838s) [56.120343] [010/170] (953s left) gem_basic (bad-close) [56.272312] Starting subtest: bad-close [56.274526] Subtest bad-close: SUCCESS (0.001s) [56.353302] [011/170] (953s left) gem_basic (create-close) [56.503427] Starting subtest: create-close [56.505882] Subtest create-close: SUCCESS (0.000s) [56.586315] [012/170] (953s left) gem_basic (create-fd-close) [56.729328] Starting subtest: create-fd-close [56.731687] Subtest create-fd-close: SUCCESS (0.001s) [56.805108] [013/170] (953s left) gem_busy (busy@all-engines) [56.969729] Starting subtest: busy [56.970796] Starting dynamic subtest: all-engines [57.047411] Dynamic subtest all-engines: SUCCESS (0.077s) [57.048672] Subtest busy: SUCCESS (0.078s) [57.390559] [014/170] (952s left) gem_close_race (basic-process) [57.559901] Starting subtest: basic-process [57.628889] Subtest basic-process: SUCCESS (0.071s) [57.821847] [015/170] (952s left) gem_close_race (basic-threads) [57.989500] Starting subtest: basic-threads [59.137919] Subtest basic-threads: SUCCESS (1.151s) [59.322564] [016/170] (950s left) gem_ctx_create (basic) [59.485321] Starting subtest: basic [59.486447] Subtest basic: SUCCESS (0.000s) [59.672557] [017/170] (950s left) gem_ctx_create (basic-files) [59.849045] Starting subtest: basic-files [61.879196] Subtest basic-files: SUCCESS (2.030s) [62.091297] [018/170] (947s left) gem_ctx_exec (basic) [62.244140] Starting subtest: basic [62.247152] Subtest basic: SUCCESS (0.005s) [62.326024] [019/170] (947s left) gem_exec_basic (basic) [62.479285] Starting subtest: basic [62.480361] Starting dynamic subtest: rcs0-smem [62.483277] Dynamic subtest rcs0-smem: SUCCESS (0.004s) [62.494692] Starting dynamic subtest: bcs0-smem [62.495833] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [62.504489] Starting dynamic subtest: vcs0-smem [62.505627] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [62.514096] Starting dynamic subtest: vecs0-smem [62.515266] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [62.516417] Subtest basic: SUCCESS (0.008s) [62.689834] [020/170] (947s left) gem_exec_create (basic) [62.854341] Starting subtest: basic [62.855478] Starting dynamic subtest: smem [64.899227] Dynamic subtest smem: SUCCESS (2.045s) [64.900629] Subtest basic: SUCCESS (2.045s) [65.090923] [021/170] (944s left) gem_exec_fence (basic-busy) [65.383023] Starting subtest: basic-busy [65.384071] Starting dynamic subtest: rcs0 [65.402504] Dynamic subtest rcs0: SUCCESS (0.022s) [65.412523] Starting dynamic subtest: bcs0 [65.428566] Dynamic subtest bcs0: SUCCESS (0.026s) [65.438834] Starting dynamic subtest: vcs0 [65.446293] Dynamic subtest vcs0: SUCCESS (0.017s) [65.458230] Starting dynamic subtest: vecs0 [65.460944] Dynamic subtest vecs0: SUCCESS (0.014s) [65.462248] Subtest basic-busy: SUCCESS (0.080s) [66.106469] [022/170] (943s left) gem_exec_fence (basic-wait) [66.394382] Starting subtest: basic-wait [66.396051] Starting dynamic subtest: rcs0 [66.409193] Dynamic subtest rcs0: SUCCESS (0.016s) [66.420412] Starting dynamic subtest: bcs0 [66.427609] Dynamic subtest bcs0: SUCCESS (0.017s) [66.439886] Starting dynamic subtest: vcs0 [66.446307] Dynamic subtest vcs0: SUCCESS (0.016s) [66.457615] Starting dynamic subtest: vecs0 [66.458751] Dynamic subtest vecs0: SUCCESS (0.013s) [66.459916] Subtest basic-wait: SUCCESS (0.064s) [67.039158] [023/170] (943s left) gem_exec_fence (basic-await) [67.328025] Starting subtest: basic-await [67.329832] Starting dynamic subtest: rcs0 [67.432620] Dynamic subtest rcs0: SUCCESS (0.104s) [67.443666] Starting dynamic subtest: bcs0 [67.535607] Dynamic subtest bcs0: SUCCESS (0.103s) [67.546770] Starting dynamic subtest: vcs0 [67.639560] Dynamic subtest vcs0: SUCCESS (0.104s) [67.649777] Starting dynamic subtest: vecs0 [67.746344] Dynamic subtest vecs0: SUCCESS (0.106s) [67.747501] Subtest basic-await: SUCCESS (0.418s) [68.340334] [024/170] (941s left) gem_exec_fence (nb-await) [68.631149] Starting subtest: nb-await [68.633840] Starting dynamic subtest: rcs0 [68.697519] Dynamic subtest rcs0: SUCCESS (0.067s) [68.707469] Starting dynamic subtest: bcs0 [68.767760] Dynamic subtest bcs0: SUCCESS (0.068s) [68.780077] Starting dynamic subtest: vcs0 [68.833540] Dynamic subtest vcs0: SUCCESS (0.064s) [68.845609] Starting dynamic subtest: vecs0 [68.893647] Dynamic subtest vecs0: SUCCESS (0.063s) [68.894855] Subtest nb-await: SUCCESS (0.264s) [69.474287] [025/170] (940s left) gem_exec_gttfill (basic) [69.635925] Starting subtest: basic [81.893630] Subtest basic: SUCCESS (12.256s) [82.095122] [026/170] (928s left) gem_exec_parallel (engines) [82.360211] Starting subtest: engines [82.362432] Starting dynamic subtest: basic [85.349289] Dynamic subtest basic: SUCCESS (2.985s) [85.361873] Starting dynamic subtest: contexts [88.985990] Dynamic subtest contexts: SUCCESS (3.635s) [88.998401] Starting dynamic subtest: fds [93.022555] Dynamic subtest fds: SUCCESS (4.039s) [93.040215] Starting dynamic subtest: userptr [96.410547] Dynamic subtest userptr: SUCCESS (3.387s) [96.411720] Subtest engines: SUCCESS (14.050s) [96.593407] [027/170] (913s left) gem_exec_store (basic) [96.764349] Starting subtest: basic [96.807625] Subtest basic: SUCCESS (0.044s) [96.991321] [028/170] (913s left) gem_flink_basic (bad-flink) [97.137326] Starting subtest: bad-flink [97.138520] Subtest bad-flink: SUCCESS (0.000s) [97.208182] [029/170] (913s left) gem_flink_basic (bad-open) [97.352369] Starting subtest: bad-open [97.353379] Subtest bad-open: SUCCESS (0.000s) [97.425103] [030/170] (912s left) gem_flink_basic (basic) [97.566686] Starting subtest: basic [97.568172] Subtest basic: SUCCESS (0.000s) [97.642060] [031/170] (912s left) gem_flink_basic (double-flink) [97.782775] Starting subtest: double-flink [97.783895] Subtest double-flink: SUCCESS (0.000s) [97.874657] [032/170] (912s left) gem_flink_basic (flink-lifetime) [98.020284] Starting subtest: flink-lifetime [98.021368] Subtest flink-lifetime: SUCCESS (0.002s) [98.107824] [033/170] (912s left) gem_huc_copy (huc-copy) [98.256769] Starting subtest: huc-copy [98.259500] Subtest huc-copy: SKIP (0.000s) [98.339649] [034/170] (912s left) gem_linear_blits (basic) [98.653710] Starting subtest: basic [98.668932] Subtest basic: SUCCESS (0.013s) [98.800187] [035/170] (911s left) gem_mmap (basic) [99.042466] Starting subtest: basic [99.048256] Subtest basic: SUCCESS (0.001s) [99.123870] [036/170] (911s left) gem_mmap_gtt (basic) [99.271071] Starting subtest: basic [99.272184] Subtest basic: SUCCESS (0.001s) [99.326434] [037/170] (911s left) gem_render_linear_blits (basic) [99.474530] Starting subtest: basic [99.536475] Subtest basic: SUCCESS (0.060s) [99.593687] [038/170] (910s left) gem_render_tiled_blits (basic) [99.738968] Starting subtest: basic [99.820939] Subtest basic: SUCCESS (0.079s) [99.862389] [039/170] (910s left) gem_ringfill (basic-all) [100.198849] Starting subtest: basic-all [101.379321] Subtest basic-all: SUCCESS (1.180s) [101.472076] [040/170] (909s left) gem_softpin (allocator-basic) [101.625328] Starting subtest: allocator-basic [101.803872] Subtest allocator-basic: SUCCESS (0.178s) [101.907748] [041/170] (908s left) gem_softpin (allocator-basic-reserve) [102.057858] Starting subtest: allocator-basic-reserve [102.230809] Subtest allocator-basic-reserve: SUCCESS (0.173s) [102.341362] [042/170] (908s left) gem_softpin (safe-alignment) [102.492373] Starting subtest: safe-alignment [102.514176] Subtest safe-alignment: SUCCESS (0.020s) [102.608641] [043/170] (907s left) gem_sync (basic-all) [102.771857] Starting subtest: basic-all [105.438620] Subtest basic-all: SUCCESS (2.666s) [105.625526] [044/170] (905s left) gem_sync (basic-each) [105.789127] Starting subtest: basic-each [108.123366] Subtest basic-each: SUCCESS (2.334s) [108.310739] [045/170] (902s left) gem_tiled_blits (basic) [108.609673] Starting subtest: basic [108.644053] Subtest basic: SUCCESS (0.033s) [108.771766] [046/170] (901s left) gem_tiled_fence_blits (basic) [109.180974] Starting subtest: basic [109.210460] Subtest basic: SUCCESS (0.031s) [109.354962] [047/170] (901s left) gem_tiled_pread_basic [109.907945] [048/170] (900s left) gem_wait (busy@all-engines) [110.078461] Starting subtest: busy [110.080088] Starting dynamic subtest: all-engines [110.603684] Dynamic subtest all-engines: SUCCESS (0.523s) [110.605139] Subtest busy: SUCCESS (0.524s) [110.822717] [049/170] (899s left) gem_wait (wait@all-engines) [111.004600] Starting subtest: wait [111.008939] Starting dynamic subtest: all-engines [112.042735] Dynamic subtest all-engines: SUCCESS (1.035s) [112.043934] Subtest wait: SUCCESS (1.038s) [112.260938] [050/170] (898s left) i915_getparams_basic (basic-eu-total) [112.405045] Starting subtest: basic-eu-total [112.407212] Subtest basic-eu-total: SUCCESS (0.000s) [112.473355] [051/170] (898s left) i915_getparams_basic (basic-subslice-total) [112.615478] Starting subtest: basic-subslice-total [112.617799] Subtest basic-subslice-total: SUCCESS (0.000s) [112.692743] [052/170] (898s left) i915_hangman (error-state-basic) [112.856113] Starting subtest: error-state-basic [112.872043] Subtest error-state-basic: SUCCESS (0.015s) [112.956498] [053/170] (897s left) i915_pciid [113.175771] [054/170] (897s left) kms_addfb_basic (addfb25-bad-modifier) [113.324013] Starting subtest: addfb25-bad-modifier [113.326845] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [113.471642] [055/170] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [113.620650] Starting subtest: addfb25-framebuffer-vs-set-tiling [113.621822] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [113.771901] [056/170] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [113.918423] Starting subtest: addfb25-modifier-no-flag [113.919584] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [114.054666] [057/170] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [114.201531] Starting subtest: addfb25-x-tiled-legacy [114.202632] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [114.338177] [058/170] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [114.480342] Starting subtest: addfb25-x-tiled-mismatch-legacy [114.481411] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [114.622053] [059/170] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [114.838361] Starting subtest: addfb25-yf-tiled-legacy [114.839432] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [114.921902] [060/170] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [115.135787] Starting subtest: addfb25-y-tiled-legacy [115.137273] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [115.221833] [061/170] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [115.436536] Starting subtest: addfb25-y-tiled-small-legacy [115.437756] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [115.521915] [062/170] (895s left) kms_addfb_basic (bad-pitch-0) [115.666383] Starting subtest: bad-pitch-0 [115.667541] Subtest bad-pitch-0: SUCCESS (0.000s) [115.821962] [063/170] (895s left) kms_addfb_basic (bad-pitch-1024) [115.977895] Starting subtest: bad-pitch-1024 [115.979129] Subtest bad-pitch-1024: SUCCESS (0.000s) [116.138557] [064/170] (895s left) kms_addfb_basic (bad-pitch-128) [116.282291] Starting subtest: bad-pitch-128 [116.283552] Subtest bad-pitch-128: SUCCESS (0.000s) [116.438624] [065/170] (894s left) kms_addfb_basic (bad-pitch-256) [116.585796] Starting subtest: bad-pitch-256 [116.587129] Subtest bad-pitch-256: SUCCESS (0.000s) [116.738461] [066/170] (894s left) kms_addfb_basic (bad-pitch-32) [116.882410] Starting subtest: bad-pitch-32 [116.883594] Subtest bad-pitch-32: SUCCESS (0.000s) [117.038522] [067/170] (894s left) kms_addfb_basic (bad-pitch-63) [117.182966] Starting subtest: bad-pitch-63 [117.184429] Subtest bad-pitch-63: SUCCESS (0.000s) [117.355617] [068/170] (893s left) kms_addfb_basic (bad-pitch-65536) [117.498985] Starting subtest: bad-pitch-65536 [117.500456] Subtest bad-pitch-65536: SUCCESS (0.001s) [117.637825] [069/170] (893s left) kms_addfb_basic (bad-pitch-999) [117.792726] Starting subtest: bad-pitch-999 [117.793866] Subtest bad-pitch-999: SUCCESS (0.000s) [117.938723] [070/170] (893s left) kms_addfb_basic (basic) [118.081069] Starting subtest: basic [118.082171] Subtest basic: SUCCESS (0.000s) [118.221868] [071/170] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [118.368205] Starting subtest: basic-x-tiled-legacy [118.369255] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [118.521797] [072/170] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [118.667313] Starting subtest: basic-y-tiled-legacy [118.669640] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [118.821748] [073/170] (892s left) kms_addfb_basic (bo-too-small) [119.033437] Starting subtest: bo-too-small [119.034506] Subtest bo-too-small: SUCCESS (0.001s) [119.122398] [074/170] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [119.327964] Starting subtest: bo-too-small-due-to-tiling [119.332696] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [119.421930] [075/170] (892s left) kms_addfb_basic (clobberred-modifier) [119.568354] Starting subtest: clobberred-modifier [119.569673] Subtest clobberred-modifier: SUCCESS (0.001s) [119.721892] [076/170] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [119.868282] Starting subtest: framebuffer-vs-set-tiling [119.869431] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [120.021813] [077/170] (891s left) kms_addfb_basic (invalid-get-prop) [120.164215] Starting subtest: invalid-get-prop [120.165387] Subtest invalid-get-prop: SUCCESS (0.000s) [120.306104] [078/170] (891s left) kms_addfb_basic (invalid-get-prop-any) [120.449598] Starting subtest: invalid-get-prop-any [120.450834] Subtest invalid-get-prop-any: SUCCESS (0.000s) [120.605257] [079/170] (890s left) kms_addfb_basic (invalid-set-prop) [120.749762] Starting subtest: invalid-set-prop [120.750916] Subtest invalid-set-prop: SUCCESS (0.000s) [120.906130] [080/170] (890s left) kms_addfb_basic (invalid-set-prop-any) [121.053771] Starting subtest: invalid-set-prop-any [121.055146] Subtest invalid-set-prop-any: SUCCESS (0.000s) [121.205344] [081/170] (890s left) kms_addfb_basic (no-handle) [121.350296] Starting subtest: no-handle [121.351377] Subtest no-handle: SUCCESS (0.000s) [121.488266] [082/170] (890s left) kms_addfb_basic (size-max) [121.701430] Starting subtest: size-max [121.702576] Subtest size-max: SUCCESS (0.001s) [121.788564] [083/170] (889s left) kms_addfb_basic (small-bo) [121.999444] Starting subtest: small-bo [122.000583] Subtest small-bo: SUCCESS (0.000s) [122.087848] [084/170] (889s left) kms_addfb_basic (tile-pitch-mismatch) [122.231604] Starting subtest: tile-pitch-mismatch [122.232905] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [122.388737] [085/170] (889s left) kms_addfb_basic (too-high) [122.598074] Starting subtest: too-high [122.599214] Subtest too-high: SUCCESS (0.002s) [122.689689] [086/170] (889s left) kms_addfb_basic (too-wide) [122.899993] Starting subtest: too-wide [122.901463] Subtest too-wide: SUCCESS (0.000s) [122.988606] [087/170] (888s left) kms_addfb_basic (unused-handle) [123.131737] Starting subtest: unused-handle [123.133050] Subtest unused-handle: SUCCESS (0.000s) [123.289722] [088/170] (888s left) kms_addfb_basic (unused-modifier) [123.429852] Starting subtest: unused-modifier [123.431038] Subtest unused-modifier: SUCCESS (0.000s) [123.572271] [089/170] (888s left) kms_addfb_basic (unused-offsets) [123.715609] Starting subtest: unused-offsets [123.716892] Subtest unused-offsets: SUCCESS (0.000s) [123.871935] [090/170] (887s left) kms_addfb_basic (unused-pitches) [124.017377] Starting subtest: unused-pitches [124.018471] Subtest unused-pitches: SUCCESS (0.000s) [124.171989] [091/170] (887s left) kms_busy (basic) [124.399666] Starting subtest: basic [124.405245] Starting dynamic subtest: flip [125.294191] Dynamic subtest flip: SUCCESS (0.884s) [125.314143] Starting dynamic subtest: modeset [126.756938] Dynamic subtest modeset: SUCCESS (1.463s) [126.758243] Subtest basic: SUCCESS (2.358s) [126.957944] [092/170] (884s left) kms_chamelium_hpd (dp-hpd-fast) [127.397948] Subtest dp-hpd-fast: SKIP (0.000s) [127.556699] [093/170] (884s left) kms_chamelium_edid (dp-edid-read) [127.997354] Subtest dp-edid-read: SKIP (0.000s) [128.146137] [094/170] (883s left) kms_chamelium_frames (dp-crc-fast) [128.581653] Subtest dp-crc-fast: SKIP (0.000s) [128.730984] [095/170] (883s left) kms_chamelium_hpd (hdmi-hpd-fast) [129.173775] Subtest hdmi-hpd-fast: SKIP (0.000s) [129.328777] [096/170] (882s left) kms_chamelium_edid (hdmi-edid-read) [129.764364] Subtest hdmi-edid-read: SKIP (0.000s) [129.918327] [097/170] (882s left) kms_chamelium_frames (hdmi-crc-fast) [130.356220] Subtest hdmi-crc-fast: SKIP (0.000s) [130.472807] [098/170] (881s left) kms_chamelium_hpd (vga-hpd-fast) [130.909875] Subtest vga-hpd-fast: SKIP (0.000s) [131.060513] [099/170] (881s left) kms_chamelium_edid (vga-edid-read) [131.500262] Subtest vga-edid-read: SKIP (0.000s) [131.648974] [100/170] (880s left) kms_prop_blob (basic) [131.793468] Starting subtest: basic [131.794676] Subtest basic: SUCCESS (0.000s) [131.859172] [101/170] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [132.072564] Starting subtest: basic-busy-flip-before-cursor-atomic [132.074868] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [132.159407] [102/170] (880s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [132.356736] Starting subtest: basic-busy-flip-before-cursor-legacy [132.359348] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [132.426776] [103/170] (879s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [132.638336] Starting subtest: basic-flip-after-cursor-atomic [133.840247] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.202s) [134.037879] [104/170] (878s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [134.250256] Starting subtest: basic-flip-after-cursor-legacy [135.477758] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.228s) [135.641157] [105/170] (876s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [135.854980] Starting subtest: basic-flip-after-cursor-varying-size [137.051820] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.197s) [137.208782] [106/170] (875s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [137.411280] Starting subtest: basic-flip-before-cursor-atomic [138.577475] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.169s) [138.733716] [107/170] (873s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [138.950753] Starting subtest: basic-flip-before-cursor-legacy [140.144552] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.193s) [140.319986] [108/170] (872s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [140.528173] Starting subtest: basic-flip-before-cursor-varying-size [141.712292] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.181s) [141.875234] [109/170] (870s left) kms_flip (basic-flip-vs-dpms) [142.058669] Starting subtest: basic-flip-vs-dpms [142.061477] Starting dynamic subtest: A-HDMI-A2 [143.294255] Dynamic subtest A-HDMI-A2: SUCCESS (1.233s) [143.316933] Starting dynamic subtest: B-HDMI-A2 [144.366791] Dynamic subtest B-HDMI-A2: SUCCESS (1.069s) [144.393882] Starting dynamic subtest: C-HDMI-A2 [145.535535] Dynamic subtest C-HDMI-A2: SUCCESS (1.155s) [145.536729] Subtest basic-flip-vs-dpms: SUCCESS (3.476s) [145.802370] [110/170] (866s left) kms_flip (basic-flip-vs-modeset) [145.995253] Starting subtest: basic-flip-vs-modeset [146.001196] Starting dynamic subtest: A-HDMI-A2 [147.528829] Dynamic subtest A-HDMI-A2: SUCCESS (1.527s) [147.554901] Starting dynamic subtest: B-HDMI-A2 [148.752612] Dynamic subtest B-HDMI-A2: SUCCESS (1.208s) [148.772886] Starting dynamic subtest: C-HDMI-A2 [150.006446] Dynamic subtest C-HDMI-A2: SUCCESS (1.239s) [150.007447] Subtest basic-flip-vs-modeset: SUCCESS (4.012s) [150.232119] [111/170] (862s left) kms_flip (basic-flip-vs-wf_vblank) [150.429570] Starting subtest: basic-flip-vs-wf_vblank [150.436319] Starting dynamic subtest: A-HDMI-A2 [151.946230] Dynamic subtest A-HDMI-A2: SUCCESS (1.504s) [151.970806] Starting dynamic subtest: B-HDMI-A2 [153.386548] Dynamic subtest B-HDMI-A2: SUCCESS (1.439s) [153.408883] Starting dynamic subtest: C-HDMI-A2 [154.878796] Dynamic subtest C-HDMI-A2: SUCCESS (1.478s) [154.880126] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.442s) [155.282519] [112/170] (857s left) kms_flip (basic-plain-flip) [155.467839] Starting subtest: basic-plain-flip [155.473100] Starting dynamic subtest: A-HDMI-A2 [156.695916] Dynamic subtest A-HDMI-A2: SUCCESS (1.217s) [156.717894] Starting dynamic subtest: B-HDMI-A2 [157.852316] Dynamic subtest B-HDMI-A2: SUCCESS (1.143s) [157.875044] Starting dynamic subtest: C-HDMI-A2 [159.003901] Dynamic subtest C-HDMI-A2: SUCCESS (1.141s) [159.004962] Subtest basic-plain-flip: SUCCESS (3.537s) [159.425456] [113/170] (853s left) kms_force_connector_basic (force-connector-state) [159.693081] Starting subtest: force-connector-state [161.229097] Subtest force-connector-state: SUCCESS (1.537s) [161.767272] [114/170] (850s left) kms_force_connector_basic (force-edid) [162.024361] Starting subtest: force-edid [162.091161] Subtest force-edid: SUCCESS (0.068s) [162.433877] [115/170] (850s left) kms_force_connector_basic (force-load-detect) [162.697596] Starting subtest: force-load-detect [162.700840] Subtest force-load-detect: SKIP (0.000s) [162.983967] [116/170] (849s left) kms_force_connector_basic (prune-stale-modes) [163.249603] Starting subtest: prune-stale-modes [163.339486] Subtest prune-stale-modes: SUCCESS (0.087s) [163.667214] [117/170] (848s left) kms_frontbuffer_tracking (basic) [163.908993] Starting subtest: basic [166.739399] Subtest basic: SUCCESS (2.830s) [166.834842] [118/170] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [167.066246] Starting subtest: compare-crc-sanitycheck [167.072187] Starting dynamic subtest: pipe-A-HDMI-A-2 [167.653243] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.581s) [167.683919] Starting dynamic subtest: pipe-B-HDMI-A-2 [168.480412] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.807s) [168.508912] Starting dynamic subtest: pipe-C-HDMI-A-2 [169.996792] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.500s) [169.999177] Subtest compare-crc-sanitycheck: SUCCESS (2.930s) [170.209707] [119/170] (842s left) kms_pipe_crc_basic (hang-read-crc) [170.440245] Starting subtest: hang-read-crc [170.446210] Starting dynamic subtest: pipe-A-HDMI-A-2 [171.978234] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.532s) [172.006934] Starting dynamic subtest: pipe-B-HDMI-A-2 [174.018324] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.023s) [174.047209] Starting dynamic subtest: pipe-C-HDMI-A-2 [177.015920] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.981s) [177.017218] Subtest hang-read-crc: SUCCESS (6.575s) [177.230924] [120/170] (835s left) kms_pipe_crc_basic (nonblocking-crc) [177.458049] Starting subtest: nonblocking-crc [177.462205] Starting dynamic subtest: pipe-A-HDMI-A-2 [178.237269] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.775s) [178.263904] Starting dynamic subtest: pipe-B-HDMI-A-2 [179.269145] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.017s) [179.298885] Starting dynamic subtest: pipe-C-HDMI-A-2 [180.540170] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.252s) [180.541237] Subtest nonblocking-crc: SUCCESS (3.082s) [180.754723] [121/170] (831s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [180.983835] Starting subtest: nonblocking-crc-frame-sequence [180.988072] Starting dynamic subtest: pipe-A-HDMI-A-2 [181.765529] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.777s) [181.792894] Starting dynamic subtest: pipe-B-HDMI-A-2 [183.036136] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.256s) [183.065923] Starting dynamic subtest: pipe-C-HDMI-A-2 [184.570657] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.517s) [184.571762] Subtest nonblocking-crc-frame-sequence: SUCCESS (3.590s) [184.774068] [122/170] (827s left) kms_pipe_crc_basic (read-crc) [185.012916] Starting subtest: read-crc [185.019395] Starting dynamic subtest: pipe-A-HDMI-A-2 [185.720781] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.695s) [185.743908] Starting dynamic subtest: pipe-B-HDMI-A-2 [186.958454] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.222s) [186.985897] Starting dynamic subtest: pipe-C-HDMI-A-2 [188.211342] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.238s) [188.212445] Subtest read-crc: SUCCESS (3.197s) [188.432483] [123/170] (824s left) kms_pipe_crc_basic (read-crc-frame-sequence) [188.658723] Starting subtest: read-crc-frame-sequence [188.664750] Starting dynamic subtest: pipe-A-HDMI-A-2 [189.373359] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.709s) [189.401927] Starting dynamic subtest: pipe-B-HDMI-A-2 [190.257399] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.863s) [190.286501] Starting dynamic subtest: pipe-C-HDMI-A-2 [191.300361] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.034s) [191.301444] Subtest read-crc-frame-sequence: SUCCESS (2.641s) [191.514712] [124/170] (821s left) kms_psr (primary_page_flip) [191.663877] Subtest primary_page_flip: SKIP (0.000s) [191.715608] [125/170] (821s left) kms_psr (cursor_plane_move) [191.859656] Subtest cursor_plane_move: SKIP (0.000s) [191.915606] [126/170] (820s left) kms_psr (sprite_plane_onoff) [192.059619] Subtest sprite_plane_onoff: SKIP (0.000s) [192.115571] [127/170] (820s left) kms_psr (primary_mmap_gtt) [192.258059] Subtest primary_mmap_gtt: SKIP (0.000s) [192.300023] [128/170] (820s left) kms_setmode (basic-clone-single-crtc) [192.444776] Starting subtest: basic-clone-single-crtc [192.448270] Subtest basic-clone-single-crtc: SKIP (0.001s) [192.529488] [129/170] (820s left) i915_pm_backlight (basic-brightness) [192.757798] Subtest basic-brightness: SKIP (0.000s) [192.815631] [130/170] (820s left) i915_pm_rpm (basic-pci-d3-state) [194.700908] Starting subtest: basic-pci-d3-state [195.410840] Subtest basic-pci-d3-state: SUCCESS (0.709s) [195.543762] [131/170] (817s left) i915_pm_rpm (basic-rte) [195.687803] Starting subtest: basic-rte [197.910256] Subtest basic-rte: SUCCESS (2.221s) [198.834538] [132/170] (814s left) i915_pm_rps (basic-api) [198.992425] Starting subtest: basic-api [199.002768] Subtest basic-api: SUCCESS (0.010s) [199.083655] [133/170] (813s left) prime_self_import (basic-llseek-bad) [199.227761] Starting subtest: basic-llseek-bad [199.232350] Subtest basic-llseek-bad: SUCCESS (0.005s) [199.317568] [134/170] (813s left) prime_self_import (basic-llseek-size) [199.457320] Starting subtest: basic-llseek-size [199.465297] Subtest basic-llseek-size: SUCCESS (0.008s) [199.549565] [135/170] (813s left) prime_self_import (basic-with_fd_dup) [199.690678] Starting subtest: basic-with_fd_dup [199.703778] Subtest basic-with_fd_dup: SUCCESS (0.013s) [199.783129] [136/170] (813s left) prime_self_import (basic-with_one_bo) [199.925623] Starting subtest: basic-with_one_bo [199.937653] Subtest basic-with_one_bo: SUCCESS (0.012s) [200.003059] [137/170] (813s left) prime_self_import (basic-with_one_bo_two_files) [200.144538] Starting subtest: basic-with_one_bo_two_files [200.152128] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s) [200.233030] [138/170] (812s left) prime_self_import (basic-with_two_bos) [200.378474] Starting subtest: basic-with_two_bos [200.387162] Subtest basic-with_two_bos: SUCCESS (0.010s) [200.467129] [139/170] (812s left) prime_vgem (basic-fence-flip) [200.633520] Starting subtest: basic-fence-flip [201.145514] Subtest basic-fence-flip: SUCCESS (0.512s) [201.234156] [140/170] (812s left) prime_vgem (basic-fence-mmap) [201.401959] Starting subtest: basic-fence-mmap [201.464114] Subtest basic-fence-mmap: SUCCESS (0.060s) [201.550857] [141/170] (811s left) prime_vgem (basic-fence-read) [201.723892] Starting subtest: basic-fence-read [201.821961] Subtest basic-fence-read: SUCCESS (0.096s) [201.900842] [142/170] (811s left) prime_vgem (basic-gtt) [202.068397] Starting subtest: basic-gtt [202.102350] Subtest basic-gtt: SUCCESS (0.034s) [202.183329] [143/170] (811s left) prime_vgem (basic-read) [202.351504] Starting subtest: basic-read [202.400132] Subtest basic-read: SUCCESS (0.048s) [202.483400] [144/170] (810s left) prime_vgem (basic-write) [202.653266] Starting subtest: basic-write [202.707719] Subtest basic-write: SUCCESS (0.054s) [202.783313] [145/170] (810s left) vgem_basic (setversion) [202.936661] Starting subtest: setversion [202.939532] Subtest setversion: SUCCESS (0.000s) [202.999862] [146/170] (810s left) vgem_basic (create) [203.153232] Starting subtest: create [203.156286] Subtest create: SUCCESS (0.002s) [203.216393] [147/170] (810s left) vgem_basic (debugfs) [203.370122] Starting subtest: debugfs [203.373267] Subtest debugfs: SUCCESS (0.003s) [203.432651] [148/170] (810s left) vgem_basic (dmabuf-export) [203.586803] Starting subtest: dmabuf-export [203.596424] Subtest dmabuf-export: SUCCESS (0.009s) [203.682907] [149/170] (809s left) vgem_basic (dmabuf-fence) [203.836766] Starting subtest: dmabuf-fence [203.840437] Subtest dmabuf-fence: SUCCESS (0.003s) [203.900600] [150/170] (809s left) vgem_basic (dmabuf-fence-before) [204.053550] Starting subtest: dmabuf-fence-before [204.056965] Subtest dmabuf-fence-before: SUCCESS (0.003s) [204.117295] [151/170] (809s left) vgem_basic (dmabuf-mmap) [204.270948] Starting subtest: dmabuf-mmap [204.303631] Subtest dmabuf-mmap: SUCCESS (0.032s) [204.366355] [152/170] (809s left) vgem_basic (mmap) [204.520159] Starting subtest: mmap [204.540964] Subtest mmap: SUCCESS (0.020s) [204.599650] [153/170] (809s left) vgem_basic (second-client) [204.753553] Starting subtest: second-client [204.801586] Subtest second-client: SUCCESS (0.048s) [204.866431] [154/170] (808s left) vgem_basic (sysfs) [205.022219] Starting subtest: sysfs [205.023705] Subtest sysfs: SUCCESS (0.002s) [205.083026] [155/170] (808s left) core_hotunplug (unbind-rebind) [205.286155] Starting subtest: unbind-rebind [206.931070] Subtest unbind-rebind: SUCCESS (1.641s) [207.032459] [156/170] (806s left) vgem_basic (unload) [207.362719] Starting subtest: unload [236.341881] Subtest unload: SUCCESS (28.977s) [236.465430] [157/170] (777s left) i915_module_load (reload) [236.614742] Starting subtest: reload [239.533578] Subtest reload: SUCCESS (2.917s) [239.603972] [158/170] (774s left) gem_lmem_swapping (basic) [239.938089] Subtest basic: SKIP (0.000s) [240.021959] [159/170] (773s left) gem_lmem_swapping (parallel-random-engines) [240.175910] Subtest parallel-random-engines: SKIP (0.000s) [240.229625] [160/170] (773s left) gem_lmem_swapping (random-engines) [240.379281] Subtest random-engines: SKIP (0.000s) [240.429605] [161/170] (773s left) gem_lmem_swapping (verify-random) [240.580540] Subtest verify-random: SKIP (0.000s) [240.629630] [162/170] (773s left) i915_pm_rpm (module-reload) [242.650784] Starting subtest: module-reload [251.643164] Subtest module-reload: SUCCESS (8.990s) [251.670417] [163/170] (762s left) i915_selftest (live) [251.836290] Starting subtest: live [251.839581] Starting dynamic subtest: sanitycheck [252.775749] Dynamic subtest sanitycheck: SUCCESS (0.934s) [252.793981] Starting dynamic subtest: uncore [253.770474] Dynamic subtest uncore: SUCCESS (0.994s) [253.786070] Starting dynamic subtest: workarounds [254.806210] Dynamic subtest workarounds: SUCCESS (1.035s) [254.822047] Starting dynamic subtest: gt_engines [256.172525] Dynamic subtest gt_engines: SUCCESS (1.361s) [256.183083] Starting dynamic subtest: gt_timelines [268.804969] Dynamic subtest gt_timelines: SUCCESS (12.632s) [268.815157] Starting dynamic subtest: gt_contexts [269.881321] Dynamic subtest gt_contexts: SUCCESS (1.075s) [269.893186] Starting dynamic subtest: gt_lrc [273.393063] Dynamic subtest gt_lrc: SUCCESS (3.510s) [273.404646] Starting dynamic subtest: gt_mocs [274.276648] Dynamic subtest gt_mocs: SUCCESS (0.883s) [274.293973] Starting dynamic subtest: gt_pm [281.094152] Dynamic subtest gt_pm: SUCCESS (6.816s) [281.110909] Starting dynamic subtest: gt_heartbeat [282.219696] Dynamic subtest gt_heartbeat: SUCCESS (1.126s) [282.256052] Starting dynamic subtest: gt_tlb [284.028028] Dynamic subtest gt_tlb: SUCCESS (1.783s) [284.038479] Starting dynamic subtest: requests [291.377911] Dynamic subtest requests: SUCCESS (7.348s) [291.388468] Starting dynamic subtest: migrate [295.216611] Dynamic subtest migrate: SUCCESS (3.837s) [295.227453] Starting dynamic subtest: active [296.156315] Dynamic subtest active: SUCCESS (0.940s) [296.170976] Starting dynamic subtest: objects [299.249246] Dynamic subtest objects: SUCCESS (3.090s) [299.259467] Starting dynamic subtest: mman [305.974057] Dynamic subtest mman: SUCCESS (6.722s) [305.984615] Starting dynamic subtest: dmabuf [306.869485] Dynamic subtest dmabuf: SUCCESS (0.895s) [306.887041] Starting dynamic subtest: vma [307.773295] Dynamic subtest vma: SUCCESS (0.901s) [307.787832] Starting dynamic subtest: coherency [312.922076] Dynamic subtest coherency: SUCCESS (5.146s) [312.933718] Starting dynamic subtest: gtt [321.382897] Dynamic subtest gtt: SUCCESS (8.459s) [321.393678] Starting dynamic subtest: gem [322.325537] Dynamic subtest gem: SUCCESS (0.942s) [322.343049] Starting dynamic subtest: evict [325.640036] Dynamic subtest evict: SUCCESS (3.312s) [325.651723] Starting dynamic subtest: hugepages [332.285027] Dynamic subtest hugepages: SUCCESS (6.644s) [332.296514] Starting dynamic subtest: gem_contexts [349.309252] Dynamic subtest gem_contexts: SUCCESS (17.022s) [349.321655] Starting dynamic subtest: client [350.156603] Dynamic subtest client: SUCCESS (0.847s) [350.173953] Starting dynamic subtest: gem_migrate [350.986945] Dynamic subtest gem_migrate: SUCCESS (0.829s) [351.004098] Starting dynamic subtest: reset [356.145057] Dynamic subtest reset: SUCCESS (5.154s) [356.156337] Starting dynamic subtest: memory_region [357.000325] Dynamic subtest memory_region: SUCCESS (0.854s) [357.014902] Starting dynamic subtest: hangcheck [381.125066] Dynamic subtest hangcheck: SUCCESS (24.121s) [381.136048] Starting dynamic subtest: execlists [390.994843] Dynamic subtest execlists: SUCCESS (9.868s) [391.006938] Starting dynamic subtest: ring_submission [391.932468] Dynamic subtest ring_submission: SUCCESS (0.937s) [391.948934] Starting dynamic subtest: perf [393.011611] Dynamic subtest perf: SUCCESS (1.077s) [393.023956] Starting dynamic subtest: slpc [393.823673] Dynamic subtest slpc: SUCCESS (0.810s) [393.842073] Starting dynamic subtest: guc [394.713414] Dynamic subtest guc: SUCCESS (0.888s) [394.730957] Starting dynamic subtest: guc_multi_lrc [395.617638] Dynamic subtest guc_multi_lrc: SUCCESS (0.903s) [395.633954] Starting dynamic subtest: guc_hang [396.558508] Dynamic subtest guc_hang: SUCCESS (0.939s) [396.576083] Starting dynamic subtest: late_gt_pm [397.511274] Dynamic subtest late_gt_pm: SUCCESS (0.951s) [397.512409] Subtest live: SUCCESS (145.674s) [397.650391] [164/170] (616s left) dmabuf (all-tests) [397.802619] Starting subtest: all-tests [397.806794] Starting dynamic subtest: sanitycheck [397.860668] Dynamic subtest sanitycheck: SUCCESS (0.058s) [397.880035] Starting dynamic subtest: dma_fence [398.060250] Dynamic subtest dma_fence: SUCCESS (0.195s) [398.072055] Starting dynamic subtest: dma_fence_chain [415.679069] Dynamic subtest dma_fence_chain: SUCCESS (17.617s) [415.692986] Starting dynamic subtest: dma_fence_unwrap [415.742895] Dynamic subtest dma_fence_unwrap: SUCCESS (0.064s) [415.762413] Starting dynamic subtest: dma_resv [415.797860] Dynamic subtest dma_resv: SUCCESS (0.053s) [415.799856] Subtest all-tests: SUCCESS (17.998s) [415.826403] [165/170] (598s left) i915_suspend (basic-s2idle-without-i915) [415.965581] Starting subtest: basic-s2idle-without-i915 [434.319999] Subtest basic-s2idle-without-i915: SUCCESS (3.974s) [439.610264] [166/170] (593s left) i915_suspend (basic-s3-without-i915) [439.755788] Starting subtest: basic-s3-without-i915 [461.335357] Subtest basic-s3-without-i915: SUCCESS (5.186s) [464.674211] [167/170] (588s left) gem_exec_suspend (basic-s0) [464.847273] Starting subtest: basic-S0 [464.850600] Starting dynamic subtest: smem [484.981780] Dynamic subtest smem: SUCCESS (4.621s) [484.982934] Subtest basic-S0: SUCCESS (4.624s) [491.147388] [168/170] (583s left) gem_exec_suspend (basic-s3) [491.312951] Starting subtest: basic-S3 [491.314608] Starting dynamic subtest: smem [513.949683] Dynamic subtest smem: SUCCESS (6.444s) [513.950762] Subtest basic-S3: SUCCESS (6.445s) [517.117359] [169/170] (576s left) kms_chamelium_hpd (common-hpd-after-suspend) [517.595754] Subtest common-hpd-after-suspend: SKIP (0.000s) [517.789837] [170/170] (575s left) kms_pipe_crc_basic (suspend-read-crc) [518.001312] Starting subtest: suspend-read-crc [518.006511] Starting dynamic subtest: pipe-A-HDMI-A-2 [539.159548] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (4.242s) [539.189689] Starting dynamic subtest: pipe-B-HDMI-A-2 [560.492642] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (4.846s) [560.528203] Starting dynamic subtest: pipe-C-HDMI-A-2 [582.452592] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.282s) [582.453662] Subtest suspend-read-crc: SUCCESS (14.413s) [587.612718] Closing watchdogs Done.